builder: autoland_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-005 starttime: 1468898478.71 results: success (0) buildid: 20160718185519 builduid: 5ec54ba6c96b436baba3849dec0b55b5 revision: 649120d26209ce3787aff18222f387ce73127694 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 20:21:18.706410) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 20:21:18.706875) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 20:21:18.707175) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 20:21:18.864698) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 20:21:18.865296) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1468898469.589196-1815931882 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-18 20:21:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.5M=0s 2016-07-18 20:21:19 (40.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.398560 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 20:21:19.278903) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 20:21:19.279247) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1468898469.589196-1815931882 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018640 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 20:21:19.328897) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 20:21:19.329259) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 649120d26209ce3787aff18222f387ce73127694 --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 649120d26209ce3787aff18222f387ce73127694 --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=7fc86f70bae03e018da0b1d8000001c4-1468898469.589196-1815931882 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-18 20:21:19,713 truncating revision to first 12 chars 2016-07-18 20:21:19,713 Setting DEBUG logging. 2016-07-18 20:21:19,713 attempt 1/10 2016-07-18 20:21:19,713 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/649120d26209?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-18 20:21:20,052 unpacking tar archive at: autoland-649120d26209/testing/mozharness/ program finished with exit code 0 elapsedTime=0.685835 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 20:21:20.030070) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 20:21:20.030400) ========= script_repo_revision: 649120d26209ce3787aff18222f387ce73127694 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 20:21:20.030789) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 20:21:20.031083) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 20:21:20.041353) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-07-18 20:21:20.041753) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1468898469.589196-1815931882 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:21:20 INFO - MultiFileLogger online at 20160718 20:21:20 in /builds/slave/test 20:21:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 20:21:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:21:20 INFO - {'append_to_log': False, 20:21:20 INFO - 'base_work_dir': '/builds/slave/test', 20:21:20 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 20:21:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:21:20 INFO - 'branch': 'Autoland-Non-PGO', 20:21:20 INFO - 'buildbot_json_path': 'buildprops.json', 20:21:20 INFO - 'config_files': ('talos/linux_config.py',), 20:21:20 INFO - 'default_actions': ('clobber', 20:21:20 INFO - 'read-buildbot-config', 20:21:20 INFO - 'download-and-extract', 20:21:20 INFO - 'populate-webroot', 20:21:20 INFO - 'create-virtualenv', 20:21:20 INFO - 'install', 20:21:20 INFO - 'run-tests'), 20:21:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:21:20 INFO - 'download_minidump_stackwalk': True, 20:21:20 INFO - 'download_symbols': 'ondemand', 20:21:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:21:20 INFO - 'tooltool.py': '/tools/tooltool.py', 20:21:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:21:20 INFO - '/tools/misc-python/virtualenv.py')}, 20:21:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:21:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:21:20 INFO - 'installer_path': 'installer.exe', 20:21:20 INFO - 'log_level': 'info', 20:21:20 INFO - 'log_name': 'talos', 20:21:20 INFO - 'log_to_console': True, 20:21:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:21:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:21:20 INFO - 'opt_config_files': (), 20:21:20 INFO - 'pip_index': False, 20:21:20 INFO - 'sps_profile': False, 20:21:20 INFO - 'sps_profile_interval': 0, 20:21:20 INFO - 'suite': 'dromaeojs-e10s', 20:21:20 INFO - 'system_bits': '32', 20:21:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:21:20 INFO - 'title': 'talos-linux64-ix-005', 20:21:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:21:20 INFO - 'use_talos_json': True, 20:21:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:21:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:21:20 INFO - 'work_dir': 'build'} 20:21:20 INFO - ##### 20:21:20 INFO - ##### Running clobber step. 20:21:20 INFO - ##### 20:21:20 INFO - Running pre-action listener: _resource_record_pre_action 20:21:20 INFO - Running main action method: clobber 20:21:20 INFO - rmtree: /builds/slave/test/build 20:21:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:21:20 INFO - Running post-action listener: _resource_record_post_action 20:21:20 INFO - ##### 20:21:20 INFO - ##### Finished clobber step (success) 20:21:20 INFO - ##### 20:21:20 INFO - ##### 20:21:20 INFO - ##### Running read-buildbot-config step. 20:21:20 INFO - ##### 20:21:20 INFO - Running pre-action listener: _resource_record_pre_action 20:21:20 INFO - Running main action method: read_buildbot_config 20:21:20 INFO - Using buildbot properties: 20:21:20 INFO - { 20:21:20 INFO - "project": "", 20:21:20 INFO - "product": "firefox", 20:21:20 INFO - "script_repo_revision": "production", 20:21:20 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 20:21:20 INFO - "repository": "", 20:21:20 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs-e10s", 20:21:20 INFO - "buildid": "20160718185519", 20:21:20 INFO - "pgo_build": "False", 20:21:20 INFO - "basedir": "/builds/slave/test", 20:21:20 INFO - "buildnumber": 91, 20:21:20 INFO - "slavename": "talos-linux64-ix-005", 20:21:20 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:21:20 INFO - "platform": "ubuntu64_hw", 20:21:20 INFO - "scheduler": "tests-autoland-linux64-talos", 20:21:20 INFO - "branch": "autoland", 20:21:20 INFO - "repo_path": "integration/autoland", 20:21:20 INFO - "revision": "649120d26209ce3787aff18222f387ce73127694", 20:21:20 INFO - "stage_platform": "linux64", 20:21:20 INFO - "builduid": "5ec54ba6c96b436baba3849dec0b55b5", 20:21:20 INFO - "slavebuilddir": "test" 20:21:20 INFO - } 20:21:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/Up5-wcboQyWGb8w0HJgM1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 20:21:20 INFO - Running post-action listener: _resource_record_post_action 20:21:20 INFO - ##### 20:21:20 INFO - ##### Finished read-buildbot-config step (success) 20:21:20 INFO - ##### 20:21:20 INFO - ##### 20:21:20 INFO - ##### Running download-and-extract step. 20:21:20 INFO - ##### 20:21:20 INFO - Running pre-action listener: _resource_record_pre_action 20:21:20 INFO - Running main action method: download_and_extract 20:21:20 INFO - mkdir: /builds/slave/test/build/tests 20:21: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:21:20 INFO - https://queue.taskcluster.net/v1/task/Up5-wcboQyWGb8w0HJgM1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:21:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Up5-wcboQyWGb8w0HJgM1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:21:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Up5-wcboQyWGb8w0HJgM1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:21:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Up5-wcboQyWGb8w0HJgM1A/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:21:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Up5-wcboQyWGb8w0HJgM1A/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:21:21 INFO - Downloaded 1361 bytes. 20:21:21 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:21:21 INFO - Using the following test package requirements: 20:21:21 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:21:21 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:21:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:21:21 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:21:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:21:21 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:21:21 INFO - u'jsshell-linux-x86_64.zip'], 20:21:21 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:21:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:21:21 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:21:21 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:21:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:21:21 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:21:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:21:21 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:21:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:21:21 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:21:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:21:21 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:21:21 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:21:21 INFO - https://queue.taskcluster.net/v1/task/Up5-wcboQyWGb8w0HJgM1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:21:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Up5-wcboQyWGb8w0HJgM1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:21:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Up5-wcboQyWGb8w0HJgM1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:21:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Up5-wcboQyWGb8w0HJgM1A/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:21:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Up5-wcboQyWGb8w0HJgM1A/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:21:22 INFO - Downloaded 22765083 bytes. 20:21:22 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:21:22 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:21:23 INFO - Return code: 0 20:21:23 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:21: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:21:23 INFO - https://queue.taskcluster.net/v1/task/Up5-wcboQyWGb8w0HJgM1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:21:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Up5-wcboQyWGb8w0HJgM1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:21:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Up5-wcboQyWGb8w0HJgM1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:21:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Up5-wcboQyWGb8w0HJgM1A/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:21:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Up5-wcboQyWGb8w0HJgM1A/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:21:25 INFO - Downloaded 22765083 bytes. 20:21:25 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:21:25 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:21:26 INFO - Return code: 0 20:21: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:21:26 INFO - https://queue.taskcluster.net/v1/task/Up5-wcboQyWGb8w0HJgM1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:21:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Up5-wcboQyWGb8w0HJgM1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:21:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Up5-wcboQyWGb8w0HJgM1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:21:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Up5-wcboQyWGb8w0HJgM1A/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:21:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Up5-wcboQyWGb8w0HJgM1A/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:21:27 INFO - Downloaded 14403317 bytes. 20:21:27 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:21:27 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:21:27 INFO - Return code: 0 20:21:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:21:27 INFO - https://queue.taskcluster.net/v1/task/Up5-wcboQyWGb8w0HJgM1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:21:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Up5-wcboQyWGb8w0HJgM1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:21:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Up5-wcboQyWGb8w0HJgM1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:21:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Up5-wcboQyWGb8w0HJgM1A/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:21:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Up5-wcboQyWGb8w0HJgM1A/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:21:29 INFO - Downloaded 57131073 bytes. 20:21:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Up5-wcboQyWGb8w0HJgM1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:21:29 INFO - mkdir: /builds/slave/test/properties 20:21:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:21:29 INFO - Writing to file /builds/slave/test/properties/build_url 20:21:29 INFO - Contents: 20:21:29 INFO - build_url:https://queue.taskcluster.net/v1/task/Up5-wcboQyWGb8w0HJgM1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:21:30 INFO - Running post-action listener: _resource_record_post_action 20:21:30 INFO - Running post-action listener: set_extra_try_arguments 20:21:30 INFO - ##### 20:21:30 INFO - ##### Finished download-and-extract step (success) 20:21:30 INFO - ##### 20:21:30 INFO - ##### 20:21:30 INFO - ##### Running populate-webroot step. 20:21:30 INFO - ##### 20:21:30 INFO - Running pre-action listener: _resource_record_pre_action 20:21:30 INFO - Running main action method: populate_webroot 20:21:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:21:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:21:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:21:30 INFO - '--tppagecycles', 20:21:30 INFO - '7'], 20:21:30 INFO - 'tests': ['tsvgm']}}, 20:21:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:21:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:21:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:21:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:21:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:21:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:21:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:21:30 INFO - 'talos_options': ['--disable-e10s'], 20:21:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:21:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:21:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:21:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:21:30 INFO - 'talos_options': ['--disable-e10s'], 20:21:30 INFO - 'tests': ['damp', 'tps']}, 20:21:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:21:30 INFO - 'tests': ['damp', 'tps']}, 20:21:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:21:30 INFO - 'tests': ['dromaeo_dom']}, 20:21:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:21:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:21:30 INFO - 'tests': ['basic_compositor_video']}, 20:21:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:21:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:21:30 INFO - 'tests': ['a11yr', 20:21:30 INFO - 'ts_paint', 20:21:30 INFO - 'tpaint', 20:21:30 INFO - 'sessionrestore', 20:21:30 INFO - 'sessionrestore_no_auto_restore', 20:21:30 INFO - 'tabpaint']}, 20:21:30 INFO - 'other-e10s': {'tests': ['a11yr', 20:21:30 INFO - 'ts_paint', 20:21:30 INFO - 'tpaint', 20:21:30 INFO - 'sessionrestore', 20:21:30 INFO - 'sessionrestore_no_auto_restore', 20:21:30 INFO - 'tabpaint']}, 20:21:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:21:30 INFO - 'ts_paint', 20:21:30 INFO - 'tpaint', 20:21:30 INFO - 'sessionrestore', 20:21:30 INFO - 'sessionrestore_no_auto_restore', 20:21:30 INFO - 'tabpaint']}, 20:21:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:21:30 INFO - 'ts_paint', 20:21:30 INFO - 'tpaint', 20:21:30 INFO - 'sessionrestore', 20:21:30 INFO - 'sessionrestore_no_auto_restore', 20:21:30 INFO - 'tabpaint']}, 20:21:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:21:30 INFO - 'tests': ['a11yr', 20:21:30 INFO - 'ts_paint', 20:21:30 INFO - 'tpaint', 20:21:30 INFO - 'sessionrestore', 20:21:30 INFO - 'sessionrestore_no_auto_restore', 20:21:30 INFO - 'tabpaint']}, 20:21:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:21:30 INFO - 'tests': ['a11yr', 20:21:30 INFO - 'ts_paint', 20:21:30 INFO - 'tpaint', 20:21:30 INFO - 'sessionrestore', 20:21:30 INFO - 'sessionrestore_no_auto_restore', 20:21:30 INFO - 'tabpaint']}, 20:21:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:21:30 INFO - 'tests': ['tsvgx', 20:21:30 INFO - 'tsvgr_opacity', 20:21:30 INFO - 'tart', 20:21:30 INFO - 'tscrollx', 20:21:30 INFO - 'cart']}, 20:21:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:21:30 INFO - 'tsvgr_opacity', 20:21:30 INFO - 'tart', 20:21:30 INFO - 'tscrollx', 20:21:30 INFO - 'cart']}, 20:21:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:21:30 INFO - 'talos_options': ['--disable-e10s'], 20:21:30 INFO - 'tests': ['tp5o']}, 20:21:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:21:30 INFO - 'tests': ['tp5o']}, 20:21:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:21:30 INFO - 'talos_options': ['--disable-e10s', 20:21:30 INFO - '--xperf_path', 20:21:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:21:30 INFO - 'tests': ['tp5n']}, 20:21:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:21:30 INFO - 'talos_options': ['--xperf_path', 20:21:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:21:30 INFO - 'tests': ['tp5n']}}, 20:21:30 INFO - 'talos.zip': {'path': '', 20:21:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:21:30 INFO - Running post-action listener: _resource_record_post_action 20:21:30 INFO - ##### 20:21:30 INFO - ##### Finished populate-webroot step (success) 20:21:30 INFO - ##### 20:21:30 INFO - ##### 20:21:30 INFO - ##### Running create-virtualenv step. 20:21:30 INFO - ##### 20:21:30 INFO - Running pre-action listener: _resource_record_pre_action 20:21:30 INFO - Running main action method: create_virtualenv 20:21:30 INFO - Creating virtualenv /builds/slave/test/build/venv 20:21:30 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:21:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:21:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:21:30 INFO - Using real prefix '/usr' 20:21:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:21:30 INFO - Installing distribute.............................................................................................................................................................................................done. 20:21:32 INFO - Installing pip.................done. 20:21:32 INFO - Return code: 0 20:21:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:21:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:21:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:21:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:21:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:21:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:21:32 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 0x28fb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b2a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb9570>, '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 0x2bba470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bba900>, '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': '7fc86f70bae03e018da0b1d8000001c4-1468898469.589196-1815931882', '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:21:32 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:21:32 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:21:32 INFO - Using env: {'DISPLAY': ':0', 20:21:32 INFO - 'HOME': '/home/cltbld', 20:21:32 INFO - 'LANG': 'en_US.UTF-8', 20:21:32 INFO - 'LANGUAGE': 'en_US:en', 20:21:32 INFO - 'LOGNAME': 'cltbld', 20:21:32 INFO - 'MAIL': '/var/mail/cltbld', 20:21:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:21:32 INFO - 'MOZ_NO_REMOTE': '1', 20:21:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:21:32 INFO - 'NO_EM_RESTART': '1', 20:21:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:21:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:21:32 INFO - 'PWD': '/builds/slave/test', 20:21:32 INFO - 'SHELL': '/bin/bash', 20:21:32 INFO - 'SHLVL': '1', 20:21:32 INFO - 'TERM': 'linux', 20:21:32 INFO - 'TMOUT': '86400', 20:21:32 INFO - 'USER': 'cltbld', 20:21:32 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1468898469.589196-1815931882', 20:21:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:21:32 INFO - '_': '/tools/buildbot/bin/python'} 20:21:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:21:32 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:21:32 INFO - Cleaning up... 20:21:32 INFO - Return code: 0 20:21:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:21:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:21:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:21:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:21:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:21:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:21:32 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 0x28fb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b2a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb9570>, '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 0x2bba470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bba900>, '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': '7fc86f70bae03e018da0b1d8000001c4-1468898469.589196-1815931882', '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:21:32 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:21:32 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:21:32 INFO - Using env: {'DISPLAY': ':0', 20:21:32 INFO - 'HOME': '/home/cltbld', 20:21:32 INFO - 'LANG': 'en_US.UTF-8', 20:21:32 INFO - 'LANGUAGE': 'en_US:en', 20:21:32 INFO - 'LOGNAME': 'cltbld', 20:21:32 INFO - 'MAIL': '/var/mail/cltbld', 20:21:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:21:32 INFO - 'MOZ_NO_REMOTE': '1', 20:21:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:21:32 INFO - 'NO_EM_RESTART': '1', 20:21:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:21:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:21:32 INFO - 'PWD': '/builds/slave/test', 20:21:32 INFO - 'SHELL': '/bin/bash', 20:21:32 INFO - 'SHLVL': '1', 20:21:32 INFO - 'TERM': 'linux', 20:21:32 INFO - 'TMOUT': '86400', 20:21:32 INFO - 'USER': 'cltbld', 20:21:32 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1468898469.589196-1815931882', 20:21:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:21:32 INFO - '_': '/tools/buildbot/bin/python'} 20:21:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:21:33 INFO - Downloading/unpacking psutil>=3.1.1 20:21:33 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:21:33 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:21:33 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:21:33 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:21:33 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:21:33 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:21:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:21:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:21:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:21:35 INFO - Installing collected packages: psutil 20:21:35 INFO - Running setup.py install for psutil 20:21:35 INFO - building 'psutil._psutil_linux' extension 20:21:35 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:21:35 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:21:35 INFO - building 'psutil._psutil_posix' extension 20:21:35 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:21:35 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:21:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:21:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:21:35 INFO - Successfully installed psutil 20:21:35 INFO - Cleaning up... 20:21:35 INFO - Return code: 0 20:21:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:21:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:21:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:21:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:21:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:21:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:21:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:21:35 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 0x28fb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b2a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb9570>, '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 0x2bba470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bba900>, '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': '7fc86f70bae03e018da0b1d8000001c4-1468898469.589196-1815931882', '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:21:35 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:21:35 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:21:35 INFO - Using env: {'DISPLAY': ':0', 20:21:35 INFO - 'HOME': '/home/cltbld', 20:21:35 INFO - 'LANG': 'en_US.UTF-8', 20:21:35 INFO - 'LANGUAGE': 'en_US:en', 20:21:35 INFO - 'LOGNAME': 'cltbld', 20:21:35 INFO - 'MAIL': '/var/mail/cltbld', 20:21:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:21:35 INFO - 'MOZ_NO_REMOTE': '1', 20:21:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:21:35 INFO - 'NO_EM_RESTART': '1', 20:21:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:21:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:21:35 INFO - 'PWD': '/builds/slave/test', 20:21:35 INFO - 'SHELL': '/bin/bash', 20:21:35 INFO - 'SHLVL': '1', 20:21:35 INFO - 'TERM': 'linux', 20:21:35 INFO - 'TMOUT': '86400', 20:21:35 INFO - 'USER': 'cltbld', 20:21:35 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1468898469.589196-1815931882', 20:21:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:21:35 INFO - '_': '/tools/buildbot/bin/python'} 20:21:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:21:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:21:35 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:21:35 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:21:35 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:21:35 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:21:35 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:21:35 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:21:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:21:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:21:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:21:37 INFO - Installing collected packages: mozsystemmonitor 20:21:37 INFO - Running setup.py install for mozsystemmonitor 20:21:37 INFO - Successfully installed mozsystemmonitor 20:21:37 INFO - Cleaning up... 20:21:37 INFO - Return code: 0 20:21:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:21:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:21:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:21:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:21:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:21:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:21:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:21:37 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 0x28fb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b2a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb9570>, '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 0x2bba470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bba900>, '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': '7fc86f70bae03e018da0b1d8000001c4-1468898469.589196-1815931882', '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:21:37 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:21:37 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:21:37 INFO - Using env: {'DISPLAY': ':0', 20:21:37 INFO - 'HOME': '/home/cltbld', 20:21:37 INFO - 'LANG': 'en_US.UTF-8', 20:21:37 INFO - 'LANGUAGE': 'en_US:en', 20:21:37 INFO - 'LOGNAME': 'cltbld', 20:21:37 INFO - 'MAIL': '/var/mail/cltbld', 20:21:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:21:37 INFO - 'MOZ_NO_REMOTE': '1', 20:21:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:21:37 INFO - 'NO_EM_RESTART': '1', 20:21:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:21:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:21:37 INFO - 'PWD': '/builds/slave/test', 20:21:37 INFO - 'SHELL': '/bin/bash', 20:21:37 INFO - 'SHLVL': '1', 20:21:37 INFO - 'TERM': 'linux', 20:21:37 INFO - 'TMOUT': '86400', 20:21:37 INFO - 'USER': 'cltbld', 20:21:37 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1468898469.589196-1815931882', 20:21:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:21:37 INFO - '_': '/tools/buildbot/bin/python'} 20:21:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:21:38 INFO - Downloading/unpacking jsonschema==2.5.1 20:21:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:21:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:21:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:21:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:21:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:21:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:21:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:21:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:21:40 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:21:40 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:21:40 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:21:40 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:21:40 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:21:40 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:21:40 INFO - Downloading functools32-3.2.3-2.tar.gz 20:21:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:21:40 INFO - warning: no files found matching '*.txt' 20:21:40 INFO - no previously-included directories found matching 'build' 20:21:40 INFO - no previously-included directories found matching 'dist' 20:21:40 INFO - no previously-included directories found matching '.git*' 20:21:40 INFO - Installing collected packages: jsonschema, functools32 20:21:40 INFO - Running setup.py install for functools32 20:21:40 INFO - warning: no files found matching '*.txt' 20:21:40 INFO - no previously-included directories found matching 'build' 20:21:40 INFO - no previously-included directories found matching 'dist' 20:21:40 INFO - no previously-included directories found matching '.git*' 20:21:40 INFO - Successfully installed jsonschema functools32 20:21:40 INFO - Cleaning up... 20:21:40 INFO - Return code: 0 20:21:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:21:40 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:21:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:21:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:21:40 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:21:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:21:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:21:40 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 0x28fb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b2a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb9570>, '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 0x2bba470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bba900>, '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': '7fc86f70bae03e018da0b1d8000001c4-1468898469.589196-1815931882', '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:21:40 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:21:40 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:21:40 INFO - Using env: {'DISPLAY': ':0', 20:21:40 INFO - 'HOME': '/home/cltbld', 20:21:40 INFO - 'LANG': 'en_US.UTF-8', 20:21:40 INFO - 'LANGUAGE': 'en_US:en', 20:21:40 INFO - 'LOGNAME': 'cltbld', 20:21:40 INFO - 'MAIL': '/var/mail/cltbld', 20:21:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:21:40 INFO - 'MOZ_NO_REMOTE': '1', 20:21:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:21:40 INFO - 'NO_EM_RESTART': '1', 20:21:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:21:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:21:40 INFO - 'PWD': '/builds/slave/test', 20:21:40 INFO - 'SHELL': '/bin/bash', 20:21:40 INFO - 'SHLVL': '1', 20:21:40 INFO - 'TERM': 'linux', 20:21:40 INFO - 'TMOUT': '86400', 20:21:40 INFO - 'USER': 'cltbld', 20:21:40 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1468898469.589196-1815931882', 20:21:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:21:40 INFO - '_': '/tools/buildbot/bin/python'} 20:21:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:21:40 INFO - Downloading/unpacking blobuploader==1.2.4 20:21:40 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:21:40 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:21:40 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:21:40 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:21:40 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:21:40 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:21:42 INFO - Downloading blobuploader-1.2.4.tar.gz 20:21:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:21:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:21:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:21:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:21:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:21:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:21:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:21:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:21:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:21:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:21:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:21:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:21:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:21:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:21:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:21:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:21:43 INFO - Downloading docopt-0.6.1.tar.gz 20:21:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:21:43 INFO - Installing collected packages: blobuploader, requests, docopt 20:21:43 INFO - Running setup.py install for blobuploader 20:21:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:21:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:21:43 INFO - Running setup.py install for requests 20:21:44 INFO - Running setup.py install for docopt 20:21:44 INFO - Successfully installed blobuploader requests docopt 20:21:44 INFO - Cleaning up... 20:21:44 INFO - Return code: 0 20:21:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:21:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:21:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:21:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:21:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:21:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:21:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:21:44 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 0x28fb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b2a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb9570>, '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 0x2bba470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bba900>, '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': '7fc86f70bae03e018da0b1d8000001c4-1468898469.589196-1815931882', '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:21:44 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:21:44 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:21:44 INFO - Using env: {'DISPLAY': ':0', 20:21:44 INFO - 'HOME': '/home/cltbld', 20:21:44 INFO - 'LANG': 'en_US.UTF-8', 20:21:44 INFO - 'LANGUAGE': 'en_US:en', 20:21:44 INFO - 'LOGNAME': 'cltbld', 20:21:44 INFO - 'MAIL': '/var/mail/cltbld', 20:21:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:21:44 INFO - 'MOZ_NO_REMOTE': '1', 20:21:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:21:44 INFO - 'NO_EM_RESTART': '1', 20:21:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:21:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:21:44 INFO - 'PWD': '/builds/slave/test', 20:21:44 INFO - 'SHELL': '/bin/bash', 20:21:44 INFO - 'SHLVL': '1', 20:21:44 INFO - 'TERM': 'linux', 20:21:44 INFO - 'TMOUT': '86400', 20:21:44 INFO - 'USER': 'cltbld', 20:21:44 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1468898469.589196-1815931882', 20:21:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:21:44 INFO - '_': '/tools/buildbot/bin/python'} 20:21:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:21:44 INFO - Running setup.py (path:/tmp/pip-WJYshs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:21:44 INFO - Running setup.py (path:/tmp/pip-3FaKIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:21:44 INFO - Running setup.py (path:/tmp/pip-jnNIHl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:21:44 INFO - Running setup.py (path:/tmp/pip-zfwlhW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:21:44 INFO - Running setup.py (path:/tmp/pip-_wEBLz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:21:44 INFO - Running setup.py (path:/tmp/pip-btH_Ra-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:21:44 INFO - Running setup.py (path:/tmp/pip-DYF4W4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:21:44 INFO - Running setup.py (path:/tmp/pip-E9Po_K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:21:44 INFO - Running setup.py (path:/tmp/pip-ocalv2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:21:45 INFO - Running setup.py (path:/tmp/pip-sHpLTB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:21:45 INFO - Running setup.py (path:/tmp/pip-j8UGiF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:21:45 INFO - Running setup.py (path:/tmp/pip-I18aQ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:21:45 INFO - Running setup.py (path:/tmp/pip-8oFjY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:21:45 INFO - Running setup.py (path:/tmp/pip-Zc1NUd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:21:45 INFO - Running setup.py (path:/tmp/pip-K_BiIq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:21:45 INFO - Running setup.py (path:/tmp/pip-JF1TdW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:21:45 INFO - Running setup.py (path:/tmp/pip-Iifx8m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:21:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:21:45 INFO - Running setup.py install for manifestparser 20:21:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:21:45 INFO - Running setup.py install for mozcrash 20:21:45 INFO - Running setup.py install for mozdebug 20:21:45 INFO - Running setup.py install for mozdevice 20:21:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:21:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:21:46 INFO - Running setup.py install for mozfile 20:21:46 INFO - Running setup.py install for mozhttpd 20:21:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:21:46 INFO - Running setup.py install for mozinfo 20:21:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:21:46 INFO - Running setup.py install for mozInstall 20:21:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:21:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:21:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:21:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:21:46 INFO - Running setup.py install for mozleak 20:21:46 INFO - Running setup.py install for mozlog 20:21:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:21:46 INFO - Running setup.py install for moznetwork 20:21:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:21:46 INFO - Running setup.py install for mozprocess 20:21:46 INFO - Running setup.py install for mozprofile 20:21:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:21:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:21:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:21:46 INFO - Running setup.py install for mozrunner 20:21:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:21:47 INFO - Running setup.py install for mozscreenshot 20:21:47 INFO - Running setup.py install for moztest 20:21:47 INFO - Running setup.py install for mozversion 20:21:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:21:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:21:47 INFO - Cleaning up... 20:21:47 INFO - Return code: 0 20:21:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:21:47 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:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:21:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:21:47 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:21:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:21:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:21:47 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 0x28fb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b2a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb9570>, '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 0x2bba470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bba900>, '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': '7fc86f70bae03e018da0b1d8000001c4-1468898469.589196-1815931882', '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:21:47 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:21:47 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:21:47 INFO - Using env: {'DISPLAY': ':0', 20:21:47 INFO - 'HOME': '/home/cltbld', 20:21:47 INFO - 'LANG': 'en_US.UTF-8', 20:21:47 INFO - 'LANGUAGE': 'en_US:en', 20:21:47 INFO - 'LOGNAME': 'cltbld', 20:21:47 INFO - 'MAIL': '/var/mail/cltbld', 20:21:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:21:47 INFO - 'MOZ_NO_REMOTE': '1', 20:21:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:21:47 INFO - 'NO_EM_RESTART': '1', 20:21:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:21:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:21:47 INFO - 'PWD': '/builds/slave/test', 20:21:47 INFO - 'SHELL': '/bin/bash', 20:21:47 INFO - 'SHLVL': '1', 20:21:47 INFO - 'TERM': 'linux', 20:21:47 INFO - 'TMOUT': '86400', 20:21:47 INFO - 'USER': 'cltbld', 20:21:47 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1468898469.589196-1815931882', 20:21:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:21:47 INFO - '_': '/tools/buildbot/bin/python'} 20:21:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:21:47 INFO - Running setup.py (path:/tmp/pip-RTfDYr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:21:47 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:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:21:47 INFO - Running setup.py (path:/tmp/pip-oTk2AE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:21:47 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:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:21:47 INFO - Running setup.py (path:/tmp/pip-j9aDYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:21:47 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:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:21:47 INFO - Running setup.py (path:/tmp/pip-a8j4AZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:21:47 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:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:21:47 INFO - Running setup.py (path:/tmp/pip-3mVx47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:21:47 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:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:21:48 INFO - Running setup.py (path:/tmp/pip-hgBJGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:21:48 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:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:21:48 INFO - Running setup.py (path:/tmp/pip-RkcL1E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:21:48 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:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:21:48 INFO - Running setup.py (path:/tmp/pip-Lk1B1Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:21:48 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:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:21:48 INFO - Running setup.py (path:/tmp/pip-8GtzG6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:21:48 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:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:21:48 INFO - Running setup.py (path:/tmp/pip-_6jj0_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:21:48 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:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:21:48 INFO - Running setup.py (path:/tmp/pip-2qvotl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:21:48 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:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:21:48 INFO - Running setup.py (path:/tmp/pip-yldfDm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:21:48 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:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:21:48 INFO - Running setup.py (path:/tmp/pip-ZUO0yA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:21:48 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:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:21:48 INFO - Running setup.py (path:/tmp/pip-t9b4lb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:21:48 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:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:21:48 INFO - Running setup.py (path:/tmp/pip-1qRKsV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:21:48 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:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:21:48 INFO - Running setup.py (path:/tmp/pip-XLrJpI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:21:48 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:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:21:48 INFO - Running setup.py (path:/tmp/pip-mW74Pg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:21:48 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:21:48 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:21:48 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:21:48 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:21:48 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:21:48 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:21:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:21:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:21:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:21:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:21:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:21:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:21:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:21:50 INFO - Downloading blessings-1.6.tar.gz 20:21:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:21:50 INFO - Installing collected packages: blessings 20:21:50 INFO - Running setup.py install for blessings 20:21:50 INFO - Successfully installed blessings 20:21:50 INFO - Cleaning up... 20:21:51 INFO - Return code: 0 20:21:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:21:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:21:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:21:51 INFO - Reading from file tmpfile_stdout 20:21:51 INFO - Current package versions: 20:21:51 INFO - argparse == 1.2.1 20:21:51 INFO - blessings == 1.6 20:21:51 INFO - blobuploader == 1.2.4 20:21:51 INFO - docopt == 0.6.1 20:21:51 INFO - functools32 == 3.2.3-2 20:21:51 INFO - jsonschema == 2.5.1 20:21:51 INFO - manifestparser == 1.1 20:21:51 INFO - mozInstall == 1.12 20:21:51 INFO - mozcrash == 0.17 20:21:51 INFO - mozdebug == 0.1 20:21:51 INFO - mozdevice == 0.48 20:21:51 INFO - mozfile == 1.2 20:21:51 INFO - mozhttpd == 0.7 20:21:51 INFO - mozinfo == 0.9 20:21:51 INFO - mozleak == 0.1 20:21:51 INFO - mozlog == 3.2 20:21:51 INFO - moznetwork == 0.27 20:21:51 INFO - mozprocess == 0.23 20:21:51 INFO - mozprofile == 0.28 20:21:51 INFO - mozrunner == 6.12 20:21:51 INFO - mozscreenshot == 0.1 20:21:51 INFO - mozsystemmonitor == 0.3 20:21:51 INFO - moztest == 0.7 20:21:51 INFO - mozversion == 1.4 20:21:51 INFO - psutil == 3.1.1 20:21:51 INFO - requests == 1.2.3 20:21:51 INFO - wsgiref == 0.1.2 20:21:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:21: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:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:21:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:21: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:21:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:21:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:21:51 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 0x28fb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b2a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb9570>, '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 0x2bba470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bba900>, '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': '7fc86f70bae03e018da0b1d8000001c4-1468898469.589196-1815931882', '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:21:51 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:21:51 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:21:51 INFO - Using env: {'DISPLAY': ':0', 20:21:51 INFO - 'HOME': '/home/cltbld', 20:21:51 INFO - 'LANG': 'en_US.UTF-8', 20:21:51 INFO - 'LANGUAGE': 'en_US:en', 20:21:51 INFO - 'LOGNAME': 'cltbld', 20:21:51 INFO - 'MAIL': '/var/mail/cltbld', 20:21:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:21:51 INFO - 'MOZ_NO_REMOTE': '1', 20:21:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:21:51 INFO - 'NO_EM_RESTART': '1', 20:21:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:21:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:21:51 INFO - 'PWD': '/builds/slave/test', 20:21:51 INFO - 'SHELL': '/bin/bash', 20:21:51 INFO - 'SHLVL': '1', 20:21:51 INFO - 'TERM': 'linux', 20:21:51 INFO - 'TMOUT': '86400', 20:21:51 INFO - 'USER': 'cltbld', 20:21:51 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1468898469.589196-1815931882', 20:21:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:21:51 INFO - '_': '/tools/buildbot/bin/python'} 20:21:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:21:51 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:21:51 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:21:51 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:21:51 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:21:51 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:21:51 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:21:51 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:21:51 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:21:51 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:21:51 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:21:51 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:21:51 INFO - Cleaning up... 20:21:51 INFO - Return code: 0 20:21:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:21: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:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:21:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:21: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:21:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:21:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:21:51 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 0x28fb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b2a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb9570>, '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 0x2bba470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bba900>, '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': '7fc86f70bae03e018da0b1d8000001c4-1468898469.589196-1815931882', '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:21:51 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:21:51 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:21:51 INFO - Using env: {'DISPLAY': ':0', 20:21:51 INFO - 'HOME': '/home/cltbld', 20:21:51 INFO - 'LANG': 'en_US.UTF-8', 20:21:51 INFO - 'LANGUAGE': 'en_US:en', 20:21:51 INFO - 'LOGNAME': 'cltbld', 20:21:51 INFO - 'MAIL': '/var/mail/cltbld', 20:21:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:21:51 INFO - 'MOZ_NO_REMOTE': '1', 20:21:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:21:51 INFO - 'NO_EM_RESTART': '1', 20:21:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:21:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:21:51 INFO - 'PWD': '/builds/slave/test', 20:21:51 INFO - 'SHELL': '/bin/bash', 20:21:51 INFO - 'SHLVL': '1', 20:21:51 INFO - 'TERM': 'linux', 20:21:51 INFO - 'TMOUT': '86400', 20:21:51 INFO - 'USER': 'cltbld', 20:21:51 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1468898469.589196-1815931882', 20:21:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:21:51 INFO - '_': '/tools/buildbot/bin/python'} 20:21:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:21:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:21:51 INFO - Cleaning up... 20:21:51 INFO - Return code: 0 20:21:51 INFO - Running post-action listener: _resource_record_post_action 20:21:51 INFO - Running post-action listener: _start_resource_monitoring 20:21:51 INFO - Starting resource monitoring. 20:21:51 INFO - ##### 20:21:51 INFO - ##### Finished create-virtualenv step (success) 20:21:51 INFO - ##### 20:21:51 INFO - ##### 20:21:51 INFO - ##### Running install step. 20:21:51 INFO - ##### 20:21:51 INFO - Running pre-action listener: _resource_record_pre_action 20:21:51 INFO - Running main action method: install 20:21:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:21:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:21:51 INFO - Reading from file tmpfile_stdout 20:21:51 INFO - Detecting whether we're running mozinstall >=1.0... 20:21:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:21:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:21:51 INFO - Reading from file tmpfile_stdout 20:21:51 INFO - Output received: 20:21:51 INFO - Usage: mozinstall [options] installer 20:21:51 INFO - Options: 20:21:51 INFO - -h, --help show this help message and exit 20:21:51 INFO - -d DEST, --destination=DEST 20:21:51 INFO - Directory to install application into. [default: 20:21:51 INFO - "/builds/slave/test"] 20:21:51 INFO - --app=APP Application being installed. [default: firefox] 20:21:51 INFO - mkdir: /builds/slave/test/build/application 20:21:51 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:21:51 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:22:08 INFO - Reading from file tmpfile_stdout 20:22:08 INFO - Output received: 20:22:08 INFO - /builds/slave/test/build/application/firefox/firefox 20:22:08 INFO - Running post-action listener: _resource_record_post_action 20:22:08 INFO - ##### 20:22:08 INFO - ##### Finished install step (success) 20:22:08 INFO - ##### 20:22:08 INFO - ##### 20:22:08 INFO - ##### Running run-tests step. 20:22:08 INFO - ##### 20:22:08 INFO - Running pre-action listener: _resource_record_pre_action 20:22:08 INFO - Running main action method: run_tests 20:22:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:22:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:22:08 INFO - Python 2.7.3 20:22:08 INFO - Return code: 0 20:22:08 INFO - grabbing minidump binary from tooltool 20:22:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:22:08 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 0x2bb9570>, '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 0x2bba470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bba900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:22:08 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:22:08 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:22:08 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:22:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:22:08 INFO - Return code: 0 20:22:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:22:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:22:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:22:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:22:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:22:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Up5-wcboQyWGb8w0HJgM1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 20:22:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Up5-wcboQyWGb8w0HJgM1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 20:22:08 INFO - Using env: {'DISPLAY': ':0', 20:22:08 INFO - 'HOME': '/home/cltbld', 20:22:08 INFO - 'LANG': 'en_US.UTF-8', 20:22:08 INFO - 'LANGUAGE': 'en_US:en', 20:22:08 INFO - 'LOGNAME': 'cltbld', 20:22:08 INFO - 'MAIL': '/var/mail/cltbld', 20:22:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:22:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:22:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:22:08 INFO - 'MOZ_NO_REMOTE': '1', 20:22:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:22:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:22:08 INFO - 'NO_EM_RESTART': '1', 20:22:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:22:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:22:08 INFO - 'PWD': '/builds/slave/test', 20:22:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:22:08 INFO - 'SHELL': '/bin/bash', 20:22:08 INFO - 'SHLVL': '1', 20:22:08 INFO - 'TERM': 'linux', 20:22:08 INFO - 'TMOUT': '86400', 20:22:08 INFO - 'USER': 'cltbld', 20:22:08 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1468898469.589196-1815931882', 20:22:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:22:08 INFO - '_': '/tools/buildbot/bin/python'} 20:22:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Up5-wcboQyWGb8w0HJgM1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 20:22:08 INFO - mozversion application_buildid: 20160718185519 20:22:08 INFO - mozversion application_changeset: 649120d26209ce3787aff18222f387ce73127694 20:22:08 INFO - mozversion application_display_name: Nightly 20:22:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:22:08 INFO - mozversion application_name: Firefox 20:22:08 INFO - mozversion application_remotingname: firefox 20:22:08 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 20:22:08 INFO - mozversion application_vendor: Mozilla 20:22:08 INFO - mozversion application_version: 50.0a1 20:22:08 INFO - mozversion platform_buildid: 20160718185519 20:22:08 INFO - mozversion platform_changeset: 649120d26209ce3787aff18222f387ce73127694 20:22:08 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 20:22:08 INFO - mozversion platform_version: 50.0a1 20:22:08 INFO - using testdate: 1468898528 20:22:08 INFO - actual date: 1468898528 20:22:08 INFO - starting webserver on 'localhost:35053' 20:22:08 INFO - SUITE-START | Running 2 tests 20:22:08 INFO - TEST-START | dromaeo_css 20:22:08 INFO - operating with platform_type : linux_ 20:22:08 INFO - Initialising browser for dromaeo_css test... 20:22:08 INFO - TEST-INFO | started process 8287 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJsAxhy/profile http://localhost:35053/getInfo.html) 20:22:13 INFO - PROCESS | 8287 | __metrics Screen width/height:1600/1200 20:22:13 INFO - PROCESS | 8287 | colorDepth:24 20:22:13 INFO - PROCESS | 8287 | Browser inner width/height: 1024/697 20:22:13 INFO - PROCESS | 8287 | __metrics 20:22:13 ERROR - PROCESS | 8287 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 20:22:14 INFO - TEST-INFO | 8287: exit 0 20:22:14 INFO - Browser initialized. 20:22:14 INFO - Running cycle 1/1 for dromaeo_css test... 20:22:14 INFO - TEST-INFO | started process 8408 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJsAxhy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:22:26 INFO - PROCESS | 8408 | RSS: Main: 169029632 20:22:26 INFO - PROCESS | 8408 | 20:23:16 INFO - PROCESS | 8408 | 1468898596388 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:25:29 INFO - PROCESS | 8408 | Cycle 1(1): loaded http://localhost:35053/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35053/tests/dromaeo/cssquery-ext.html) 20:25:30 INFO - PROCESS | 8408 | RSS: Main: 169381888 20:25:30 INFO - PROCESS | 8408 | 20:28:32 INFO - PROCESS | 8408 | Cycle 1(1): loaded http://localhost:35053/tests/dromaeo/cssquery-ext.html (next: http://localhost:35053/tests/dromaeo/cssquery-jquery.html) 20:28:33 INFO - PROCESS | 8408 | RSS: Main: 170151936 20:28:33 INFO - PROCESS | 8408 | 20:31:35 INFO - PROCESS | 8408 | Cycle 1(1): loaded http://localhost:35053/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35053/tests/dromaeo/cssquery-mootools.html) 20:31:35 INFO - PROCESS | 8408 | RSS: Main: 172716032 20:31:35 INFO - PROCESS | 8408 | 20:34:37 INFO - PROCESS | 8408 | Cycle 1(1): loaded http://localhost:35053/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35053/tests/dromaeo/cssquery-prototype.html) 20:34:38 INFO - PROCESS | 8408 | RSS: Main: 167669760 20:34:38 INFO - PROCESS | 8408 | 20:37:41 INFO - PROCESS | 8408 | Cycle 1(1): loaded http://localhost:35053/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35053/tests/dromaeo/cssquery-yui.html) 20:37:41 INFO - PROCESS | 8408 | RSS: Main: 168910848 20:37:41 INFO - PROCESS | 8408 | 20:40:44 INFO - PROCESS | 8408 | Cycle 1(1): loaded http://localhost:35053/tests/dromaeo/cssquery-yui.html (next: http://localhost:35053/tests/dromaeo/cssquery-dojo.html) 20:40:44 INFO - PROCESS | 8408 | RSS: Main: 169648128 20:40:44 INFO - PROCESS | 8408 | 20:40:44 INFO - PROCESS | 8408 | __start_tp_report 20:40:44 INFO - PROCESS | 8408 | _x_x_mozilla_page_load 20:40:44 INFO - PROCESS | 8408 | _x_x_mozilla_page_load_details 20:40:44 INFO - PROCESS | 8408 | |i|pagename|runs| 20:40:44 INFO - PROCESS | 8408 | |0;dojo.html;2580.2130350243174;2600.1809430029543;2624.908128215513;2634.7365263473657;2654.376221587925;4662.720236785791;4706.482286948437;4743.312219728137;4758.214894542396;4782.473927867932;4633.351330813689;4800.111979283826;4828.082664293782;4833.4441539223;4839.419269687643;4386.670999675021;4421.801018954155;4484.372187893698;4493.393391892102;4552.658550608701;4517.683762136652;4523.751193684346;4547.408836851205;4558.293464512989;4626.097910907374;4277.144571085795;4407.449068866392;4423.0048239145935;4450.332450132506;4514.164879497303;4406.1187762447635;4455.933161002587;4459.821607135743;4474.8881277967985;4521.615662668677;4409.823607055714;4411.117776444724;4430.113977204572;4453.688241823073;4493.0115374617535;4754.572088512051;4799.688020278671;4810.687305325143;4833.154198015369;4838.758062096881;5163.096458119814;5167.689938603696;5197.636165468419;5203.037438073969;5208.166693329049;5036.597072234213;5107.284980102789;5227.921581176285;5232.398274198478;5261.289725886994;4776.8566942991765;4793.400824896888;4805.831795887197;4808.230683090689;4855.028994201139;5249.790008399621;5252.317198764213;5257.211418287287;5266.815661451831;5306.124489459196;5046.369203849519;5050.04049230645;5052.34319538465;5081.542661160439;5109.156989096758;5020.673656212334;5079.6698214615935;5081.568066714371;5167.509086636764;5210.400803907523;5103.311053007871;5105.412877519058;5110.4634013428795;5116.923246151311;5121.334226550524;5019.071471777733;5069.771860266297;5094.2358646203365;5109.616778741609;5110.923336149961;4255.29787585045;4381.145676593033;4403;4406.162829062532;4447.421835161408;3820.9617903820604;3836.9424458633143;3866.4200369944733;3867.3425517662067;3896.6298201670797;4526.094781043805;4549.613282870993;4558.840440584564;4577.5193604671695;4606.861794146181;5144.7942082316285;5205.765740541685;5253.632245742761;5281.12861377876;5298.947010529845;4524.434445694288;4525.547445255514;4526.434195725535;4560.5895469407915;4576.81692732287;4650.255959046536;4706.717596944194;4710.8351207707565;4714.834980775657;4753.191957367256;4774.092922344744;4854.660173787801;4893.853184404474;4906.215005599087;4906.484819094015;5197.038547868657;5207.114790485551;5212.218167274939;5224.686518808883;5226.63413561047;4910.238912968495;4910.950890491049;4912.70523768575;4921.458639549575;4944.208926571731;5095.388553373619;5111.258867464123;5150.1502252127975;5154.690718556749;5179.741012949413;5190.766415511386;5233.947660523346;5239.4236633970995;5251.2123181523075;5284.313039304866;4877.585405240594;5002.449730529566;5059.16523773588;5086.821961231487;5099.6685215460875;4835.178019736582;4973.353464049796;4979.751012449436;5007.84976450707;5103.234514822806;4890.070886531547;4900.117978763857;4925.507449255046;4937.827176048965;4962.255661650781;4957.900841983068;5040.924386134284;5059.089363914531;5077.517635824591;5113.8977220454635;4941.456439791548;5000;5000.374953130859;5033.2701758245585;5050.974745126251 20:40:44 INFO - PROCESS | 8408 | |1;ext.html;560.7672815781449;563.4534501533512;567.327716655763;569.6354333226733;622.9408206220413;35740.46389304159;40052.799736001354;40096.799516002415;40097.79951100248;40165.7991710041;41154.58845411545;41782.791086044606;41824.58175418245;41885;41921.58078419215;7856.685732570704;7980;7982.720604778834;7994.960025199865;7995.400344974121;7854.7250846220395;7922.564258965755;7945.404094692893;7974.362051035903;7984.760457186294;7950.522968621873;7975.521468711896;7992.720254791084;7993.120756716757;8003.359731221517;7855.607219638995;7944.920550794504;7951.920480795205;7952.244536769055;7954.204579542057;7806.687732490694;7869.842603147905;7930;7942.086660034054;7944.245296696805;37850;38007.23985520302;38162.23675526502;38331.61668383336;38351;3129.8122112673313;3153.2905096353365;3168.936621267585;3249.4151052810485;3651.1419816343137;29567.70432295671;29757.702422975708;29955.550666740015;30118.24704382386;30314;3242.254281515241;3267.77125601208;3321.2527181383994;3322.501624756306;3373.7638365314438;260131;261480;261909;262401;262708;31871.362572748414;52982.73508632432;53664;53717.46282537203;53837.1924421134;31079;31138.221544461117;31252.374952500824;31381.372372552876;31536.526952095737;13640.931795340959;13881.930590346983;13894.305284735723;13932.094413863066;13940.884729221638;11673.824892626617;11841.348725819991;11843;11859.644210673521;11911.940440297916;7589.165191828894;7700.884486732703;7729.845403092019;7733.690652373842;7783.104942931635;2950.9409811803644;3030.3333266681293;3071.416430878126;3105.7049580289836;3107.8446077696476;845.1337379186383;895.5208963204655;905.5789058088021;929.688554334292;936.8688383626297;27307.726922730915;27702.722972770418;27799.444011119664;28314.2921426966;28479.857600711865;931.3108299858056;974.206022092007;978.0659470205936;1011.1809434358194;1048.156234231451;14656.413743450143;15000.174990375415;15056.623584410478;15227.086374817547;15264.694706106038;310276;463523;477862;479609;765142;50613.24080138801;50855;51111.74444127756;51209.48790512122;51399.743001284754;1216.555957075661;1233.8396008518835;1235.116891422637;1238.8699186585638;1240.9131360804656;28187.15438536847;29208.7079129206;29220.63962644323;29703.554446682883;29847.70152298449;43391;43570.56429435665;43870.34194487021;44034.11931761411;44212.7789361064;286497;287071;287713;287908;288421;25039.74960250447;25686.61470077913;25902.481950361263;25917.74082259153;26212.8689356552;42847.785761071;42872;43328.56671433245;43648.34527482027;44085.77957110194;37529;37613.24773504569;37675.43486847645;37680.623193768806;38083.619163808005;37466.81266593649;37680.81159594184;37684.62315376811;38062.80968595139;38107.809460952514;31285.374292514476;35951.64048359483;36726.06191504726;37418.43872341971;39321;32653.673463265062;33187.847154520285;33878.661213388536;34184.48723269103;34263.82868085644;25939.610905836806;26245.21264362072;26437;26601.467970640864;26616.467670646867 20:40:44 INFO - PROCESS | 8408 | |2;jquery.html;377.5167785234899;380.24331580155484;383.2105861924436;396.21351617040153;401.35382034923765;15902.84097159028;17266.740998885027;17596.20817063232;17662.64674706505;17710.380136695218;16963.491095267163;17092.82907170931;17579.64840703185;17803;17851.10744462778;5234.057869583483;5365.543928766059;5386.542143917772;5408.4050754416985;5412.810551630694;3784.5080139581814;5956.791512297071;6267.4045965633195;6273.968630156843;6326.177596912418;6211.751529938797;6292.339304373044;6312.49500039998;6334.936650633481;6343.6193828370215;6256.280527739277;6276.5292603054495;6298.149749783766;6304.810855674337;6326.968365158168;5395.919061214085;5544.140658197985;5566.165075238706;5596.4403559644115;5602.075657516505;21270.89364553183;21437.785622143736;21924.561508769893;22010.88994555033;22185.55958844526;1747.7378393240988;1883.303177824214;1989.8607097503182;2103.379503046605;2138.5829763196184;9351.485668288242;9586.712398628053;9766.169875560587;11111.888881111247;13952.581422557238;1777.7511148439228;1800.1629242402214;1813.3925135079764;1868.813118688134;1877.1271358818078;69009.65495172492;72628.18429539251;73184;73513.63243183804;73682.63158684225;9788.314817962817;10156.644517441853;10161.54273057714;10194.592216311265;10551.261411701107;13067.281299528428;13165.67085822843;13269.601911942656;13292;13310.733785324433;6840.897386539106;6862.725490980305;6891.27641597635;6922.619255940972;7139.750108746169;6445.871082578416;6499.220093588705;6621.702023408958;6653.800385988428;6657.267700552935;3825.4261860721112;4193.287141186006;4347.543507931685;4379.540148284448;4541.364209010741;1732.523556022104;1850.3901605603212;1855.1002763659615;1859.711744679577;1880.4734674291221;832.4963397144761;870.3298460185622;892.3218354050838;908.1644886704248;956.6125719083782;16762.161891905598;17264.568385790455;17315;17451.825481745273;17693.91153044252;850.9787255318666;872.5026734761252;877.8902637170354;885.8936927568733;886.8758373827669;9750.609975600897;9770.853437198448;9826.80346393068;9865.950670246746;9907;394152;394305;397856;405431.70125643373;408085;74447.25552744404;74832.25167748253;75292.62353688307;76778;77128;880.6213328268777;899.8245342158348;904.9547522623842;934.5047125023748;946.947917864524;15809.051456912623;15981.200939953189;16011.919940400223;16118.435854745028;16154.596135096717;36874.8156259217;37676.81161594175;37732.24535509329;38129.23741525209;38285.61714382932;49202.26196606982;50265.24602130898;54886.45113548813;55961.72019139878;56496.15255771085;7711.151773305044;7774.144844067035;8036.959815200887;8139.674413023649;8291.419600627898;9006.774830629287;11888.34614096233;12721.427535760728;12727.681807954876;12830.10189286741;4671.43942726875;8399.622017009127;10328.896711033094;10711.94644026775;10903.56385744593;10285.331453455501;10477.790444190921;10655.89344106549;10900.364945258274;11086.778264434828;9399.671011514563;10036.447995360326;10045.849312260469;10094.697159085239;10293.485325733833;7849.4897831640765;7864.882026769488;7985.08171560278;8098.271155596025;8125.79685507867;10576.84134737995;10645.059100718565;10740.087092597218;10921.726956825825;11150.944245278723 20:40:44 INFO - PROCESS | 8408 | |3;mootools.html;1384.0450089438286;1421.502474134053;1515.4998850379377;1690.7379356199792;1706.8463838254554;7038.753643622462;7573.9621301893485;7622.352100071486;8154.796130096751;8185.631646575904;7911.881321780178;7955.363570914327;7970.880436793453;8024.438289319735;8037.27664510194;2202.0861342542867;2242.473018840571;2243.8653680779125;2245.045855511409;2250.3473992542145;2059.6292667319876;2061.3506745375234;2113.6723807809813;2115.2913773885766;2119.2794449887037;2182.978170218293;2207.514346843692;2210.9447263818374;2215.789499997498;2217.911283548664;2049.784772598878;2050.354138446392;2062.556550341676;2066;2070;2121.734783152106;2147.624165770984;2164.1127137873555;2175.3039027511204;2176.5320456101854;8024.277814996678;8034.718784842561;8043.718469853586;8062.758117256433;8094.919050809475;4677.298405239241;4792.161371759928;4808.182608956451;4808.855734327975;4821.325014497973;2825.70330115337;2869.0532124398896;2903.274181454636;2916.300087978891;2983.671796102427;876.1063715010654;899.2131884600974;930.4510338900013;944.2351695126969;945.0738276489079;10780.73048173794;10822;10910.5090270938;10915.672529824118;10916.563337466492;4087.8160482777753;4161.188568229166;4278.507971583245;4291.141771645684;4413.646908247332;9329.673461428818;9339.392939458914;9421.62313507452;9425.76435589102;9427.245820334494;4626.074785043005;4641.164590373698;4658.534146585314;4659.883502912454;4664.743439110814;3697.131174174067;4173.269677806433;4196.538380778112;4221.894452638709;4367.847125350598;3623.7644553103964;3652.543432070991;3701.4632878232505;3783.5838057813617;3785.413260944558;1176.5117476247433;1182.763447310524;1189.4885199364358;1199.9280043197436;1207.5773479282357;732.4341822387237;746.7573038762424;805.4120492040726;874.9737507874773;893.1291990309396;5487.149491828773;5580.2466666999435;5594.580406469531;5780.826575202751;5805.88388232233;853.9231469167805;875.6672464463591;915.8168366326761;922.5064590444081;935.8783358163531;3680.116771974707;3811.1805961718364;3843.423486476995;3881.4177873319227;3906.4726261954274;9472.194863436547;9784.217262619115;9796.412215267106;9844.606215751433;9845.852312215322;9752.853707194397;9772.853407198756;9774.315797894222;9787;9829.901700982899;7386.926130738731;7393.8151546211775;7551.169371369145;7583.582902940391;7583.848323033619;5477.370102438112;5498.45015498447;5501.174823776306;5555.416681248573;5657.066584013592;9211.631534738535;9219.17027467531;9270.907290927275;9308.301877359361;9317.86023209639;8969.684862408283;9394.577244023898;9405.764855878659;9422.670206542738;9442.291828113057;6102.481289090477;6702.396784289437;6886.8622627548175;6938.167419909643;7088.0785497884945;7674.6162691864065;7744.8451030980195;7789.493682910593;7790.961045194737;7823.530588164728;6709.664516774239;6753.898691519729;6825.829354266183;6834.282400347892;7031.507794454339;6795.966020169867;6845.657717114224;6903.827404314932;6906.171259448898;6970.51206415546;6554.868902622016;6566.24488183865;6567.9671601641685;6572.539922205399;6628.5028622852515;4597.931031034604;4603;4620.422447194101;4760.024195040078;4848.951510484992;4738.739369334582;4763.3807605011125;4811.1820990431015;4864.6594738369395;4915.754212289443 20:40:44 INFO - PROCESS | 8408 | |4;prototype.html;302.5612861351041;303.5037713338691;306.08175473579263;309.0928125950337;311.8503118503119;4996.351204102646;5045.470225626307;5064.215046667763;5066.518680725334;5083.6441449098575;4980.576650984662;4984.37695288089;5002.649814512985;5007.549320561149;5053.242013697947;3724.459953306769;3797.696184305249;3918.1771827916173;3930.8380390785096;3934.193490334489;3901.590333015021;3916.5300163980364;3917.6278253565865;3920.4315374270714;3924.156306394125;3915.2169566086754;3916.921661566767;3919.1181984053646;3922.411638254256;3923.8234279457492;3830.8276127574327;3896.8441262349756;3915.432262321976;3925.725199236055;3935.8622448214173;3429.5198672185916;3459.411899976985;3466.584009918826;3467.3412051710093;3470.548828652259;4869.269609558559;4876.171050921352;4891.388576427947;4894.36373271476;4906.31311616374;4332.458442694663;4467.749030271497;4478.57453541913;4497.482789479219;4518.796654150571;5181.689098654055;5226.372835259755;5250.44870288618;5258.710770907599;5267.183586544092;3734.9439758403646;3753.2118255166447;3758.1168425420005;3758.248350329945;3760.7179461540495;5328.815185773814;5490.368607610136;5491;5494;5494.697791621459;3788.962110378916;3822.6559609635265;3826.617338266151;3850.114473671071;3859.9421008684894;3886.4753258309765;3894.299026175259;3903;3906.1015966327905;3909.4526766252748;4369.694121411534;4428.645708343389;4448.399466072104;4450.866474005785;4464.196444639996;5009.248612708123;5198.584113270929;5205.505476979681;5223.955208958224;5234.450382709761;1335.2922950835878;1337.806018127366;1345.7375811716622;1346.145197799385;1349.8582648821928;837.899452065756;873.6942070275353;874.0909454167721;887.8890138732659;892.4199270474244;4510.774461276923;4643.515719090338;4645.6980296280635;4661.860144195612;4675.509071547506;5382.838514844482;5448.863778405572;5449.3188351456065;5457.399686034533;5461.617686761889;4454.1982443159895;4665.160271151225;4676;4687.20317546018;4696.765161741968;2884.5240535311436;2898.4782739107163;2914.2422970027947;2914.810537315068;2916.3292442737866;5123.410807757081;5124.897502050013;5127.6154288428515;5134.563562097189;5152.330197074356;5361.488225212492;5528.253685752452;5533.557315414757;5541.362743284493;5576.498115169654;5036.899262014813;5070;5111.182210846247;5120.974395128001;5131.102057139986;5407.891842163213;5421.484958928895;5443.210734443563;5444.945550544602;5446.618736688552;5102.69383836971;5272.340957380327;5297.2583838263445;5317.813876514459;5328.600354973315;5063.620228482952;5077.019962214813;5078.771455284447;5089.491050895029;5103.413107492686;3866.6133386662236;3883.223355328889;3885.4754608128674;3890;3902.6097390261884;5188.9740551297;5371.677699338053;5379.731013449234;5410.3507579090765;5427.864303392289;5143.431253467728;5148.459411761711;5206.791728330824;5220.381681678692;5220.451852555579;5181.2746215529105;5222.206119725928;5230.686158830483;5236.5548928339995;5260.947390526046;4906.239532872411;5143;5152.948470515397;5163.09645811989;5163.948360516497;5053.29253904461;5128.538431541179;5292.7353632319;5314.3091398117995;5324.908393779188;5174.525260300947;5191.714455704972;5196.558292545176;5201.479852014768;5204.1673332266655 20:40:44 INFO - PROCESS | 8408 | |5;yui.html;627.3162253144072;631.5200447659777;639.2041907824758;710.8151880511069;732.3445516262947;11823.172377933537;11930.701732456693;12632.68418289542;12941.41763620637;12967.157134786232;12957.28734919579;13084.869151308509;13118.73762524749;13122;13148.145370550907;613.6900865063159;750.2984709296798;761.5126319155745;779.1818590479974;780.7891869195314;775.1202385292677;776.3401109057285;777.6966982876683;777.7277952716561;779.5985067690144;809.8825670277806;812.0012384766741;818.0633175014605;818.2267756969666;820.0937963550281;800.6157044618616;801.3989507869098;803.8432505661399;807.039622848811;808.1716240853173;588.0532342927883;592.3720855892724;592.48453845155;593.5844908564022;593.7061154728394;12608.74782504354;12691;12697.873021269761;12702;12755.234685918875;12889.613311600573;13129;13234.27211503367;13349.199048057148;13377.398017089254;10348.120409765179;10362.844557331646;10367.274290799647;10408.583656653725;10653.360798352123;3214.276787722767;3224.7097761201603;3269.444194486919;3326.06870076379;3344.3311337732553;60160.69919650374;60707.089393659575;61348;61461;61635;10381.169506439466;10445.68662940113;10503.842442363371;10537.525811338508;10549.47252637365;16481.505554833133;17014.829851701572;17021.65956680884;17820;18828.246870125316;7040.92959070413;7047.330503602149;7118.216996130422;7121.501494895308;7169.928300716926;3648.945265821015;3711.7030637548933;3713.4801127842125;3731.514903062639;3810.6760925321105;2750.5324094903913;2839.162447078117;2846.0465743975587;2847.2027832207013;2855.4431885782487;500.3820281951787;501.58869726824383;502.9899402011939;507.2771300896282;521.0802932823569;532.2149829002268;612.2530512774408;618.5175563060819;621.1614320667063;630.6815058395481;7836.921630783733;7980.920190798134;8080.959595201986;8227.753167404988;8333.8333233335;580.9687804147671;584.2463222443085;614.0727501472808;635.0284065379976;646.8285904235381;3929.7052721046034;4026.3970430522827;4059.6346328830546;4190.790460476964;4217.093324935154;92505;94196;95277.52361238288;95506.52246738861;96644.51677741707;64264;66161.66919165374;66687.66656166785;84743.5762821182;85070;54854.45145548494;69678.30321696718;72199.6390018057;73067.63466182635;75937.58280877373;8789.07714689974;8797.47215167092;8822.382433229612;9098.954505227697;9291.256699464162;41259.587404125574;41530.79234603808;41545;41552.96117597084;42041;54216.45783542114;58104.70947645404;58310.708446457495;58615.4138458627;59055;11224.38265895351;11250.212485125963;11408.087353011904;11423.371714555447;11458.885411146115;12912.806307905577;12979.675508112372;12983.221006739626;13486.12340197884;13691.110077844909;11264.887351126385;12309;12411.317377544321;12571.434285456993;12577.119601627799;12162;12221.694457638274;12449.066320026215;13079.280639564915;13106.082574219714;11370.94314528422;11592.768144637228;11672.941635291769;11942.283462992249;12325.322107284186;9801.80396392054;9818.263630227904;10270.589176433157;10386.532606032897;10483.58065677395;9531.952340238531;9940.204783617437;9972.252081093802;10057.195424365887;10072.143867771321 20:40:44 INFO - PROCESS | 8408 | __end_tp_report 20:40:44 INFO - PROCESS | 8408 | __start_cc_report 20:40:44 INFO - PROCESS | 8408 | _x_x_mozilla_cycle_collect,414 20:40:44 INFO - PROCESS | 8408 | __end_cc_report 20:40:44 INFO - PROCESS | 8408 | __startTimestamp1468899644740__endTimestamp 20:40:44 INFO - PROCESS | 8408 | 20:40:44 INFO - PROCESS | 8408 | ------- Summary: start ------- 20:40:44 INFO - PROCESS | 8408 | Number of tests: 6 20:40:44 INFO - PROCESS | 8408 | 20:40:44 INFO - PROCESS | 8408 | [#0] dojo.html Cycles:165 Average:4780.00 Median:4906.22 stddev:503.74 (10.3%) stddev-sans-first:474.80 20:40:44 INFO - PROCESS | 8408 | Values: 2580.2 2600.2 2624.9 2634.7 2654.4 4662.7 4706.5 4743.3 4758.2 4782.5 4633.4 4800.1 4828.1 4833.4 4839.4 4386.7 4421.8 4484.4 4493.4 4552.7 4517.7 4523.8 4547.4 4558.3 4626.1 4277.1 4407.4 4423.0 4450.3 4514.2 4406.1 4455.9 4459.8 4474.9 4521.6 4409.8 4411.1 4430.1 4453.7 4493.0 4754.6 4799.7 4810.7 4833.2 4838.8 5163.1 5167.7 5197.6 5203.0 5208.2 5036.6 5107.3 5227.9 5232.4 5261.3 4776.9 4793.4 4805.8 4808.2 4855.0 5249.8 5252.3 5257.2 5266.8 5306.1 5046.4 5050.0 5052.3 5081.5 5109.2 5020.7 5079.7 5081.6 5167.5 5210.4 5103.3 5105.4 5110.5 5116.9 5121.3 5019.1 5069.8 5094.2 5109.6 5110.9 4255.3 4381.1 4403.0 4406.2 4447.4 3821.0 3836.9 3866.4 3867.3 3896.6 4526.1 4549.6 4558.8 4577.5 4606.9 5144.8 5205.8 5253.6 5281.1 5298.9 4524.4 4525.5 4526.4 4560.6 4576.8 4650.3 4706.7 4710.8 4714.8 4753.2 4774.1 4854.7 4893.9 4906.2 4906.5 5197.0 5207.1 5212.2 5224.7 5226.6 4910.2 4911.0 4912.7 4921.5 4944.2 5095.4 5111.3 5150.2 5154.7 5179.7 5190.8 5233.9 5239.4 5251.2 5284.3 4877.6 5002.4 5059.2 5086.8 5099.7 4835.2 4973.4 4979.8 5007.8 5103.2 4890.1 4900.1 4925.5 4937.8 4962.3 4957.9 5040.9 5059.1 5077.5 5113.9 4941.5 5000.0 5000.4 5033.3 5051.0 20:40:44 INFO - PROCESS | 8408 | 20:40:44 INFO - PROCESS | 8408 | [#1] ext.html Cycles:180 Average:49230.54 Median:37571.12 stddev:100234.30 (266.8%) stddev-sans-first:100448.87 20:40:44 INFO - PROCESS | 8408 | Values: 560.8 563.5 567.3 569.6 622.9 35740.5 40052.8 40096.8 40097.8 40165.8 41154.6 41782.8 41824.6 41885.0 41921.6 7856.7 7980.0 7982.7 7995.0 7995.4 7854.7 7922.6 7945.4 7974.4 7984.8 7950.5 7975.5 7992.7 7993.1 8003.4 7855.6 7944.9 7951.9 7952.2 7954.2 7806.7 7869.8 7930.0 7942.1 7944.2 37850.0 38007.2 38162.2 38331.6 38351.0 3129.8 3153.3 3168.9 3249.4 3651.1 29567.7 29757.7 29955.6 30118.2 30314.0 3242.3 3267.8 3321.3 3322.5 3373.8 260131.0 261480.0 261909.0 262401.0 262708.0 31871.4 52982.7 53664.0 53717.5 53837.2 31079.0 31138.2 31252.4 31381.4 31536.5 13640.9 13881.9 13894.3 13932.1 13940.9 11673.8 11841.3 11843.0 11859.6 11911.9 7589.2 7700.9 7729.8 7733.7 7783.1 2950.9 3030.3 3071.4 3105.7 3107.8 845.1 895.5 905.6 929.7 936.9 27307.7 27702.7 27799.4 28314.3 28479.9 931.3 974.2 978.1 1011.2 1048.2 14656.4 15000.2 15056.6 15227.1 15264.7 310276.0 463523.0 477862.0 479609.0 765142.0 50613.2 50855.0 51111.7 51209.5 51399.7 1216.6 1233.8 1235.1 1238.9 1240.9 28187.2 29208.7 29220.6 29703.6 29847.7 43391.0 43570.6 43870.3 44034.1 44212.8 286497.0 287071.0 287713.0 287908.0 288421.0 25039.7 25686.6 25902.5 25917.7 26212.9 42847.8 42872.0 43328.6 43648.3 44085.8 37529.0 37613.2 37675.4 37680.6 38083.6 37466.8 37680.8 37684.6 38062.8 38107.8 31285.4 35951.6 36726.1 37418.4 39321.0 32653.7 33187.8 33878.7 34184.5 34263.8 25939.6 26245.2 26437.0 26601.5 26616.5 20:40:44 INFO - PROCESS | 8408 | 20:40:44 INFO - PROCESS | 8408 | [#2] jquery.html Cycles:180 Average:24912.79 Median:4363.54 stddev:66017.49 (1512.9%) stddev-sans-first:66176.98 20:40:44 INFO - PROCESS | 8408 | Values: 377.5 380.2 383.2 396.2 401.4 15902.8 17266.7 17596.2 17662.6 17710.4 16963.5 17092.8 17579.6 17803.0 17851.1 5234.1 5365.5 5386.5 5408.4 5412.8 3784.5 5956.8 6267.4 6274.0 6326.2 6211.8 6292.3 6312.5 6334.9 6343.6 6256.3 6276.5 6298.1 6304.8 6327.0 5395.9 5544.1 5566.2 5596.4 5602.1 21270.9 21437.8 21924.6 22010.9 22185.6 1747.7 1883.3 1989.9 2103.4 2138.6 9351.5 9586.7 9766.2 11111.9 13952.6 1777.8 1800.2 1813.4 1868.8 1877.1 69009.7 72628.2 73184.0 73513.6 73682.6 9788.3 10156.6 10161.5 10194.6 10551.3 13067.3 13165.7 13269.6 13292.0 13310.7 6840.9 6862.7 6891.3 6922.6 7139.8 6445.9 6499.2 6621.7 6653.8 6657.3 3825.4 4193.3 4347.5 4379.5 4541.4 1732.5 1850.4 1855.1 1859.7 1880.5 832.5 870.3 892.3 908.2 956.6 16762.2 17264.6 17315.0 17451.8 17693.9 851.0 872.5 877.9 885.9 886.9 9750.6 9770.9 9826.8 9866.0 9907.0 394152.0 394305.0 397856.0 405431.7 408085.0 74447.3 74832.3 75292.6 76778.0 77128.0 880.6 899.8 905.0 934.5 946.9 15809.1 15981.2 16011.9 16118.4 16154.6 36874.8 37676.8 37732.2 38129.2 38285.6 49202.3 50265.2 54886.5 55961.7 56496.2 7711.2 7774.1 8037.0 8139.7 8291.4 9006.8 11888.3 12721.4 12727.7 12830.1 4671.4 8399.6 10328.9 10711.9 10903.6 10285.3 10477.8 10655.9 10900.4 11086.8 9399.7 10036.4 10045.8 10094.7 10293.5 7849.5 7864.9 7985.1 8098.3 8125.8 10576.8 10645.1 10740.1 10921.7 11150.9 20:40:44 INFO - PROCESS | 8408 | 20:40:44 INFO - PROCESS | 8408 | [#3] mootools.html Cycles:180 Average:5263.51 Median:5587.41 stddev:2960.84 (53.0%) stddev-sans-first:2954.80 20:40:44 INFO - PROCESS | 8408 | Values: 1384.0 1421.5 1515.5 1690.7 1706.8 7038.8 7574.0 7622.4 8154.8 8185.6 7911.9 7955.4 7970.9 8024.4 8037.3 2202.1 2242.5 2243.9 2245.0 2250.3 2059.6 2061.4 2113.7 2115.3 2119.3 2183.0 2207.5 2210.9 2215.8 2217.9 2049.8 2050.4 2062.6 2066.0 2070.0 2121.7 2147.6 2164.1 2175.3 2176.5 8024.3 8034.7 8043.7 8062.8 8094.9 4677.3 4792.2 4808.2 4808.9 4821.3 2825.7 2869.1 2903.3 2916.3 2983.7 876.1 899.2 930.5 944.2 945.1 10780.7 10822.0 10910.5 10915.7 10916.6 4087.8 4161.2 4278.5 4291.1 4413.6 9329.7 9339.4 9421.6 9425.8 9427.2 4626.1 4641.2 4658.5 4659.9 4664.7 3697.1 4173.3 4196.5 4221.9 4367.8 3623.8 3652.5 3701.5 3783.6 3785.4 1176.5 1182.8 1189.5 1199.9 1207.6 732.4 746.8 805.4 875.0 893.1 5487.1 5580.2 5594.6 5780.8 5805.9 853.9 875.7 915.8 922.5 935.9 3680.1 3811.2 3843.4 3881.4 3906.5 9472.2 9784.2 9796.4 9844.6 9845.9 9752.9 9772.9 9774.3 9787.0 9829.9 7386.9 7393.8 7551.2 7583.6 7583.8 5477.4 5498.5 5501.2 5555.4 5657.1 9211.6 9219.2 9270.9 9308.3 9317.9 8969.7 9394.6 9405.8 9422.7 9442.3 6102.5 6702.4 6886.9 6938.2 7088.1 7674.6 7744.8 7789.5 7791.0 7823.5 6709.7 6753.9 6825.8 6834.3 7031.5 6796.0 6845.7 6903.8 6906.2 6970.5 6554.9 6566.2 6568.0 6572.5 6628.5 4597.9 4603.0 4620.4 4760.0 4849.0 4738.7 4763.4 4811.2 4864.7 4915.8 20:40:44 INFO - PROCESS | 8408 | 20:40:44 INFO - PROCESS | 8408 | [#4] prototype.html Cycles:180 Average:4363.03 Median:5008.40 stddev:1263.51 (25.2%) stddev-sans-first:1229.75 20:40:44 INFO - PROCESS | 8408 | Values: 302.6 303.5 306.1 309.1 311.9 4996.4 5045.5 5064.2 5066.5 5083.6 4980.6 4984.4 5002.6 5007.5 5053.2 3724.5 3797.7 3918.2 3930.8 3934.2 3901.6 3916.5 3917.6 3920.4 3924.2 3915.2 3916.9 3919.1 3922.4 3923.8 3830.8 3896.8 3915.4 3925.7 3935.9 3429.5 3459.4 3466.6 3467.3 3470.5 4869.3 4876.2 4891.4 4894.4 4906.3 4332.5 4467.7 4478.6 4497.5 4518.8 5181.7 5226.4 5250.4 5258.7 5267.2 3734.9 3753.2 3758.1 3758.2 3760.7 5328.8 5490.4 5491.0 5494.0 5494.7 3789.0 3822.7 3826.6 3850.1 3859.9 3886.5 3894.3 3903.0 3906.1 3909.5 4369.7 4428.6 4448.4 4450.9 4464.2 5009.2 5198.6 5205.5 5224.0 5234.5 1335.3 1337.8 1345.7 1346.1 1349.9 837.9 873.7 874.1 887.9 892.4 4510.8 4643.5 4645.7 4661.9 4675.5 5382.8 5448.9 5449.3 5457.4 5461.6 4454.2 4665.2 4676.0 4687.2 4696.8 2884.5 2898.5 2914.2 2914.8 2916.3 5123.4 5124.9 5127.6 5134.6 5152.3 5361.5 5528.3 5533.6 5541.4 5576.5 5036.9 5070.0 5111.2 5121.0 5131.1 5407.9 5421.5 5443.2 5444.9 5446.6 5102.7 5272.3 5297.3 5317.8 5328.6 5063.6 5077.0 5078.8 5089.5 5103.4 3866.6 3883.2 3885.5 3890.0 3902.6 5189.0 5371.7 5379.7 5410.4 5427.9 5143.4 5148.5 5206.8 5220.4 5220.5 5181.3 5222.2 5230.7 5236.6 5260.9 4906.2 5143.0 5152.9 5163.1 5163.9 5053.3 5128.5 5292.7 5314.3 5324.9 5174.5 5191.7 5196.6 5201.5 5204.2 20:40:44 INFO - PROCESS | 8408 | 20:40:44 INFO - PROCESS | 8408 | [#5] yui.html Cycles:180 Average:17024.04 Median:500.99 stddev:23662.72 (4723.2%) stddev-sans-first:23697.07 20:40:44 INFO - PROCESS | 8408 | Values: 627.3 631.5 639.2 710.8 732.3 11823.2 11930.7 12632.7 12941.4 12967.2 12957.3 13084.9 13118.7 13122.0 13148.1 613.7 750.3 761.5 779.2 780.8 775.1 776.3 777.7 777.7 779.6 809.9 812.0 818.1 818.2 820.1 800.6 801.4 803.8 807.0 808.2 588.1 592.4 592.5 593.6 593.7 12608.7 12691.0 12697.9 12702.0 12755.2 12889.6 13129.0 13234.3 13349.2 13377.4 10348.1 10362.8 10367.3 10408.6 10653.4 3214.3 3224.7 3269.4 3326.1 3344.3 60160.7 60707.1 61348.0 61461.0 61635.0 10381.2 10445.7 10503.8 10537.5 10549.5 16481.5 17014.8 17021.7 17820.0 18828.2 7040.9 7047.3 7118.2 7121.5 7169.9 3648.9 3711.7 3713.5 3731.5 3810.7 2750.5 2839.2 2846.0 2847.2 2855.4 500.4 501.6 503.0 507.3 521.1 532.2 612.3 618.5 621.2 630.7 7836.9 7980.9 8081.0 8227.8 8333.8 581.0 584.2 614.1 635.0 646.8 3929.7 4026.4 4059.6 4190.8 4217.1 92505.0 94196.0 95277.5 95506.5 96644.5 64264.0 66161.7 66687.7 84743.6 85070.0 54854.5 69678.3 72199.6 73067.6 75937.6 8789.1 8797.5 8822.4 9099.0 9291.3 41259.6 41530.8 41545.0 41553.0 42041.0 54216.5 58104.7 58310.7 58615.4 59055.0 11224.4 11250.2 11408.1 11423.4 11458.9 12912.8 12979.7 12983.2 13486.1 13691.1 11264.9 12309.0 12411.3 12571.4 12577.1 12162.0 12221.7 12449.1 13079.3 13106.1 11370.9 11592.8 11672.9 11942.3 12325.3 9801.8 9818.3 10270.6 10386.5 10483.6 9532.0 9940.2 9972.3 10057.2 10072.1 20:40:44 INFO - PROCESS | 8408 | -------- Summary: end -------- 20:40:44 INFO - PROCESS | 8408 | 20:40:45 INFO - TEST-INFO | 8408: exit 0 20:40:45 INFO - TEST-OK | dromaeo_css | took 1116830ms 20:40:45 INFO - TEST-START | kraken 20:40:45 INFO - operating with platform_type : linux_ 20:40:45 INFO - Initialising browser for kraken test... 20:40:45 INFO - TEST-INFO | started process 8651 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzdi5Np/profile http://localhost:35053/getInfo.html) 20:40:50 INFO - PROCESS | 8651 | __metrics Screen width/height:1600/1200 20:40:50 INFO - PROCESS | 8651 | colorDepth:24 20:40:50 INFO - PROCESS | 8651 | Browser inner width/height: 1024/697 20:40:50 INFO - PROCESS | 8651 | __metrics 20:40:50 ERROR - PROCESS | 8651 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 20:40:51 INFO - TEST-INFO | 8651: exit 0 20:40:51 INFO - Browser initialized. 20:40:51 INFO - Running cycle 1/1 for kraken test... 20:40:51 INFO - TEST-INFO | started process 8769 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzdi5Np/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:41:03 INFO - PROCESS | 8769 | RSS: Main: 168873984 20:41:03 INFO - PROCESS | 8769 | 20:41:06 INFO - PROCESS | 8769 | Cycle 1(1): loaded http://localhost:35053/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35053/tests/kraken/driver.html?testName=audio-beat-detection) 20:41:07 INFO - PROCESS | 8769 | RSS: Main: 174419968 20:41:07 INFO - PROCESS | 8769 | 20:41:09 INFO - PROCESS | 8769 | Cycle 1(1): loaded http://localhost:35053/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35053/tests/kraken/driver.html?testName=audio-dft) 20:41:10 INFO - PROCESS | 8769 | RSS: Main: 174333952 20:41:10 INFO - PROCESS | 8769 | 20:41:13 INFO - PROCESS | 8769 | Cycle 1(1): loaded http://localhost:35053/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35053/tests/kraken/driver.html?testName=audio-fft) 20:41:14 INFO - PROCESS | 8769 | RSS: Main: 169185280 20:41:14 INFO - PROCESS | 8769 | 20:41:16 INFO - PROCESS | 8769 | Cycle 1(1): loaded http://localhost:35053/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35053/tests/kraken/driver.html?testName=audio-oscillator) 20:41:16 INFO - PROCESS | 8769 | RSS: Main: 169623552 20:41:16 INFO - PROCESS | 8769 | 20:41:19 INFO - PROCESS | 8769 | Cycle 1(1): loaded http://localhost:35053/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35053/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:41:19 INFO - PROCESS | 8769 | RSS: Main: 169390080 20:41:19 INFO - PROCESS | 8769 | 20:41:22 INFO - PROCESS | 8769 | Cycle 1(1): loaded http://localhost:35053/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35053/tests/kraken/driver.html?testName=imaging-darkroom) 20:41:23 INFO - PROCESS | 8769 | RSS: Main: 170123264 20:41:23 INFO - PROCESS | 8769 | 20:41:27 INFO - PROCESS | 8769 | Cycle 1(1): loaded http://localhost:35053/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35053/tests/kraken/driver.html?testName=imaging-desaturate) 20:41:27 INFO - PROCESS | 8769 | RSS: Main: 167510016 20:41:27 INFO - PROCESS | 8769 | 20:41:30 INFO - PROCESS | 8769 | Cycle 1(1): loaded http://localhost:35053/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35053/tests/kraken/driver.html?testName=json-parse-financial) 20:41:31 INFO - PROCESS | 8769 | RSS: Main: 168902656 20:41:31 INFO - PROCESS | 8769 | 20:41:33 INFO - PROCESS | 8769 | Cycle 1(1): loaded http://localhost:35053/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35053/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:41:33 INFO - PROCESS | 8769 | RSS: Main: 169234432 20:41:33 INFO - PROCESS | 8769 | 20:41:35 INFO - PROCESS | 8769 | Cycle 1(1): loaded http://localhost:35053/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35053/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:41:36 INFO - PROCESS | 8769 | RSS: Main: 169377792 20:41:36 INFO - PROCESS | 8769 | 20:41:38 INFO - PROCESS | 8769 | Cycle 1(1): loaded http://localhost:35053/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35053/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:41:39 INFO - PROCESS | 8769 | RSS: Main: 169857024 20:41:39 INFO - PROCESS | 8769 | 20:41:42 INFO - PROCESS | 8769 | Cycle 1(1): loaded http://localhost:35053/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35053/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:41:42 INFO - PROCESS | 8769 | RSS: Main: 170098688 20:41:42 INFO - PROCESS | 8769 | 20:41:45 INFO - PROCESS | 8769 | Cycle 1(1): loaded http://localhost:35053/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35053/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:41:46 INFO - PROCESS | 8769 | RSS: Main: 170504192 20:41:46 INFO - PROCESS | 8769 | 20:41:48 INFO - PROCESS | 8769 | Cycle 1(1): loaded http://localhost:35053/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35053/tests/kraken/driver.html?testName=ai-astar) 20:41:48 INFO - PROCESS | 8769 | RSS: Main: 171130880 20:41:48 INFO - PROCESS | 8769 | 20:41:48 INFO - PROCESS | 8769 | __start_tp_report 20:41:48 INFO - PROCESS | 8769 | _x_x_mozilla_page_load 20:41:48 INFO - PROCESS | 8769 | _x_x_mozilla_page_load_details 20:41:48 INFO - PROCESS | 8769 | |i|pagename|runs| 20:41:48 INFO - PROCESS | 8769 | |0;ai-astar;107;117;108;115;114;114;116;114;114;115 20:41:48 INFO - PROCESS | 8769 | |1;audio-beat-detection;147;124;153;191;128;148;153;124;187;128 20:41:48 INFO - PROCESS | 8769 | |2;audio-dft;166;166;165;175;165;163;162;164;162;162 20:41:48 INFO - PROCESS | 8769 | |3;audio-fft;77;76;76;158;77;77;76;76;153;76 20:41:48 INFO - PROCESS | 8769 | |4;audio-oscillator;86;87;156;86;86;86;147;85;86;132 20:41:48 INFO - PROCESS | 8769 | |5;imaging-gaussian-blur;117;118;117;117;118;118;118;117;118;118 20:41:48 INFO - PROCESS | 8769 | |6;imaging-darkroom;149;149;151;148;148;148;148;147;147;147 20:41:48 INFO - PROCESS | 8769 | |7;imaging-desaturate;95;96;95;95;96;96;96;96;96;96 20:41:48 INFO - PROCESS | 8769 | |8;json-parse-financial;63;64;68;67;65;64;63;64;65;64 20:41:48 INFO - PROCESS | 8769 | |9;json-stringify-tinderbox;70;71;71;70;69;70;71;70;75;72 20:41:48 INFO - PROCESS | 8769 | |10;stanford-crypto-aes;83;86;79;84;85;84;80;80;83;79 20:41:48 INFO - PROCESS | 8769 | |11;stanford-crypto-ccm;135;128;132;145;140;142;141;140;172;139 20:41:48 INFO - PROCESS | 8769 | |12;stanford-crypto-pbkdf2;170;172;169;167;167;167;180;166;167;167 20:41:48 INFO - PROCESS | 8769 | |13;stanford-crypto-sha256-iterative;72;69;69;67;70;67;68;70;66;67 20:41:48 INFO - PROCESS | 8769 | __end_tp_report 20:41:48 INFO - PROCESS | 8769 | __start_cc_report 20:41:48 INFO - PROCESS | 8769 | _x_x_mozilla_cycle_collect,986 20:41:48 INFO - PROCESS | 8769 | __end_cc_report 20:41:48 INFO - PROCESS | 8769 | __startTimestamp1468899708356__endTimestamp 20:41:48 INFO - PROCESS | 8769 | 20:41:48 INFO - PROCESS | 8769 | ------- Summary: start ------- 20:41:48 INFO - PROCESS | 8769 | Number of tests: 14 20:41:48 INFO - PROCESS | 8769 | 20:41:48 INFO - PROCESS | 8769 | [#0] ai-astar Cycles:10 Average:113.40 Median:114.50 stddev:3.27 (2.9%) stddev-sans-first:2.52 20:41:48 INFO - PROCESS | 8769 | Values: 107.0 117.0 108.0 115.0 114.0 114.0 116.0 114.0 114.0 115.0 20:41:48 INFO - PROCESS | 8769 | 20:41:48 INFO - PROCESS | 8769 | [#1] audio-beat-detection Cycles:10 Average:148.30 Median:150.50 stddev:24.43 (16.2%) stddev-sans-first:25.91 20:41:48 INFO - PROCESS | 8769 | Values: 147.0 124.0 153.0 191.0 128.0 148.0 153.0 124.0 187.0 128.0 20:41:48 INFO - PROCESS | 8769 | 20:41:48 INFO - PROCESS | 8769 | [#2] audio-dft Cycles:10 Average:165.00 Median:165.00 stddev:3.86 (2.3%) stddev-sans-first:4.08 20:41:48 INFO - PROCESS | 8769 | Values: 166.0 166.0 165.0 175.0 165.0 163.0 162.0 164.0 162.0 162.0 20:41:48 INFO - PROCESS | 8769 | 20:41:48 INFO - PROCESS | 8769 | [#3] audio-fft Cycles:10 Average:92.20 Median:76.00 stddev:33.39 (43.9%) stddev-sans-first:34.96 20:41:48 INFO - PROCESS | 8769 | Values: 77.0 76.0 76.0 158.0 77.0 77.0 76.0 76.0 153.0 76.0 20:41:48 INFO - PROCESS | 8769 | 20:41:48 INFO - PROCESS | 8769 | [#4] audio-oscillator Cycles:10 Average:103.70 Median:86.00 stddev:29.07 (33.8%) stddev-sans-first:30.12 20:41:48 INFO - PROCESS | 8769 | Values: 86.0 87.0 156.0 86.0 86.0 86.0 147.0 85.0 86.0 132.0 20:41:48 INFO - PROCESS | 8769 | 20:41:48 INFO - PROCESS | 8769 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 20:41:48 INFO - PROCESS | 8769 | Values: 117.0 118.0 117.0 117.0 118.0 118.0 118.0 117.0 118.0 118.0 20:41:48 INFO - PROCESS | 8769 | 20:41:48 INFO - PROCESS | 8769 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:1.23 (0.8%) stddev-sans-first:1.27 20:41:48 INFO - PROCESS | 8769 | Values: 149.0 149.0 151.0 148.0 148.0 148.0 148.0 147.0 147.0 147.0 20:41:48 INFO - PROCESS | 8769 | 20:41:48 INFO - PROCESS | 8769 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 20:41:48 INFO - PROCESS | 8769 | Values: 95.0 96.0 95.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 20:41:48 INFO - PROCESS | 8769 | 20:41:48 INFO - PROCESS | 8769 | [#8] json-parse-financial Cycles:10 Average:64.70 Median:64.50 stddev:1.64 (2.5%) stddev-sans-first:1.62 20:41:48 INFO - PROCESS | 8769 | Values: 63.0 64.0 68.0 67.0 65.0 64.0 63.0 64.0 65.0 64.0 20:41:48 INFO - PROCESS | 8769 | 20:41:48 INFO - PROCESS | 8769 | [#9] json-stringify-tinderbox Cycles:10 Average:70.90 Median:71.00 stddev:1.66 (2.3%) stddev-sans-first:1.73 20:41:48 INFO - PROCESS | 8769 | Values: 70.0 71.0 71.0 70.0 69.0 70.0 71.0 70.0 75.0 72.0 20:41:48 INFO - PROCESS | 8769 | 20:41:48 INFO - PROCESS | 8769 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:83.50 stddev:2.58 (3.1%) stddev-sans-first:2.73 20:41:48 INFO - PROCESS | 8769 | Values: 83.0 86.0 79.0 84.0 85.0 84.0 80.0 80.0 83.0 79.0 20:41:48 INFO - PROCESS | 8769 | 20:41:48 INFO - PROCESS | 8769 | [#11] stanford-crypto-ccm Cycles:10 Average:141.40 Median:140.50 stddev:11.87 (8.4%) stddev-sans-first:12.36 20:41:48 INFO - PROCESS | 8769 | Values: 135.0 128.0 132.0 145.0 140.0 142.0 141.0 140.0 172.0 139.0 20:41:48 INFO - PROCESS | 8769 | 20:41:48 INFO - PROCESS | 8769 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.20 Median:168.00 stddev:4.21 (2.5%) stddev-sans-first:4.46 20:41:48 INFO - PROCESS | 8769 | Values: 170.0 172.0 169.0 167.0 167.0 167.0 180.0 166.0 167.0 167.0 20:41:48 INFO - PROCESS | 8769 | 20:41:48 INFO - PROCESS | 8769 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:69.00 stddev:1.84 (2.7%) stddev-sans-first:1.45 20:41:48 INFO - PROCESS | 8769 | Values: 72.0 69.0 69.0 67.0 70.0 67.0 68.0 70.0 66.0 67.0 20:41:48 INFO - PROCESS | 8769 | -------- Summary: end -------- 20:41:48 INFO - PROCESS | 8769 | 20:41:49 INFO - TEST-INFO | 8769: exit 0 20:41:49 INFO - TEST-OK | kraken | took 63871ms 20:41:49 INFO - SUITE-END | took 1180s 20:41:49 INFO - Completed test suite (00:19:40) 20:41:49 INFO - javascript benchmark 20:41:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6467.796509839465, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2580.2130350243174, 2600.1809430029543, 2624.908128215513, 2634.7365263473657, 2654.376221587925, 4662.720236785791, 4706.482286948437, 4743.312219728137, 4758.214894542396, 4782.473927867932, 4633.351330813689, 4800.111979283826, 4828.082664293782, 4833.4441539223, 4839.419269687643, 4386.670999675021, 4421.801018954155, 4484.372187893698, 4493.393391892102, 4552.658550608701, 4517.683762136652, 4523.751193684346, 4547.408836851205, 4558.293464512989, 4626.097910907374, 4277.144571085795, 4407.449068866392, 4423.0048239145935, 4450.332450132506, 4514.164879497303, 4406.1187762447635, 4455.933161002587, 4459.821607135743, 4474.8881277967985, 4521.615662668677, 4409.823607055714, 4411.117776444724, 4430.113977204572, 4453.688241823073, 4493.0115374617535, 4754.572088512051, 4799.688020278671, 4810.687305325143, 4833.154198015369, 4838.758062096881, 5163.096458119814, 5167.689938603696, 5197.636165468419, 5203.037438073969, 5208.166693329049, 5036.597072234213, 5107.284980102789, 5227.921581176285, 5232.398274198478, 5261.289725886994, 4776.8566942991765, 4793.400824896888, 4805.831795887197, 4808.230683090689, 4855.028994201139, 5249.790008399621, 5252.317198764213, 5257.211418287287, 5266.815661451831, 5306.124489459196, 5046.369203849519, 5050.04049230645, 5052.34319538465, 5081.542661160439, 5109.156989096758, 5020.673656212334, 5079.6698214615935, 5081.568066714371, 5167.509086636764, 5210.400803907523, 5103.311053007871, 5105.412877519058, 5110.4634013428795, 5116.923246151311, 5121.334226550524, 5019.071471777733, 5069.771860266297, 5094.2358646203365, 5109.616778741609, 5110.923336149961, 4255.29787585045, 4381.145676593033, 4403.0, 4406.162829062532, 4447.421835161408, 3820.9617903820604, 3836.9424458633143, 3866.4200369944733, 3867.3425517662067, 3896.6298201670797, 4526.094781043805, 4549.613282870993, 4558.840440584564, 4577.5193604671695, 4606.861794146181, 5144.7942082316285, 5205.765740541685, 5253.632245742761, 5281.12861377876, 5298.947010529845, 4524.434445694288, 4525.547445255514, 4526.434195725535, 4560.5895469407915, 4576.81692732287, 4650.255959046536, 4706.717596944194, 4710.8351207707565, 4714.834980775657, 4753.191957367256, 4774.092922344744, 4854.660173787801, 4893.853184404474, 4906.215005599087, 4906.484819094015, 5197.038547868657, 5207.114790485551, 5212.218167274939, 5224.686518808883, 5226.63413561047, 4910.238912968495, 4910.950890491049, 4912.70523768575, 4921.458639549575, 4944.208926571731, 5095.388553373619, 5111.258867464123, 5150.1502252127975, 5154.690718556749, 5179.741012949413, 5190.766415511386, 5233.947660523346, 5239.4236633970995, 5251.2123181523075, 5284.313039304866, 4877.585405240594, 5002.449730529566, 5059.16523773588, 5086.821961231487, 5099.6685215460875, 4835.178019736582, 4973.353464049796, 4979.751012449436, 5007.84976450707, 5103.234514822806, 4890.070886531547, 4900.117978763857, 4925.507449255046, 4937.827176048965, 4962.255661650781, 4957.900841983068, 5040.924386134284, 5059.089363914531, 5077.517635824591, 5113.8977220454635, 4941.456439791548, 5000.0, 5000.374953130859, 5033.2701758245585, 5050.974745126251], "value": 4746.897186259737, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [560.7672815781449, 563.4534501533512, 567.327716655763, 569.6354333226733, 622.9408206220413, 35740.46389304159, 40052.799736001354, 40096.799516002415, 40097.79951100248, 40165.7991710041, 41154.58845411545, 41782.791086044606, 41824.58175418245, 41885.0, 41921.58078419215, 7856.685732570704, 7980.0, 7982.720604778834, 7994.960025199865, 7995.400344974121, 7854.7250846220395, 7922.564258965755, 7945.404094692893, 7974.362051035903, 7984.760457186294, 7950.522968621873, 7975.521468711896, 7992.720254791084, 7993.120756716757, 8003.359731221517, 7855.607219638995, 7944.920550794504, 7951.920480795205, 7952.244536769055, 7954.204579542057, 7806.687732490694, 7869.842603147905, 7930.0, 7942.086660034054, 7944.245296696805, 37850.0, 38007.23985520302, 38162.23675526502, 38331.61668383336, 38351.0, 3129.8122112673313, 3153.2905096353365, 3168.936621267585, 3249.4151052810485, 3651.1419816343137, 29567.70432295671, 29757.702422975708, 29955.550666740015, 30118.24704382386, 30314.0, 3242.254281515241, 3267.77125601208, 3321.2527181383994, 3322.501624756306, 3373.7638365314438, 260131.0, 261480.0, 261909.0, 262401.0, 262708.0, 31871.362572748414, 52982.73508632432, 53664.0, 53717.46282537203, 53837.1924421134, 31079.0, 31138.221544461117, 31252.374952500824, 31381.372372552876, 31536.526952095737, 13640.931795340959, 13881.930590346983, 13894.305284735723, 13932.094413863066, 13940.884729221638, 11673.824892626617, 11841.348725819991, 11843.0, 11859.644210673521, 11911.940440297916, 7589.165191828894, 7700.884486732703, 7729.845403092019, 7733.690652373842, 7783.104942931635, 2950.9409811803644, 3030.3333266681293, 3071.416430878126, 3105.7049580289836, 3107.8446077696476, 845.1337379186383, 895.5208963204655, 905.5789058088021, 929.688554334292, 936.8688383626297, 27307.726922730915, 27702.722972770418, 27799.444011119664, 28314.2921426966, 28479.857600711865, 931.3108299858056, 974.206022092007, 978.0659470205936, 1011.1809434358194, 1048.156234231451, 14656.413743450143, 15000.174990375415, 15056.623584410478, 15227.086374817547, 15264.694706106038, 310276.0, 463523.0, 477862.0, 479609.0, 765142.0, 50613.24080138801, 50855.0, 51111.74444127756, 51209.48790512122, 51399.743001284754, 1216.555957075661, 1233.8396008518835, 1235.116891422637, 1238.8699186585638, 1240.9131360804656, 28187.15438536847, 29208.7079129206, 29220.63962644323, 29703.554446682883, 29847.70152298449, 43391.0, 43570.56429435665, 43870.34194487021, 44034.11931761411, 44212.7789361064, 286497.0, 287071.0, 287713.0, 287908.0, 288421.0, 25039.74960250447, 25686.61470077913, 25902.481950361263, 25917.74082259153, 26212.8689356552, 42847.785761071, 42872.0, 43328.56671433245, 43648.34527482027, 44085.77957110194, 37529.0, 37613.24773504569, 37675.43486847645, 37680.623193768806, 38083.619163808005, 37466.81266593649, 37680.81159594184, 37684.62315376811, 38062.80968595139, 38107.809460952514, 31285.374292514476, 35951.64048359483, 36726.06191504726, 37418.43872341971, 39321.0, 32653.673463265062, 33187.847154520285, 33878.661213388536, 34184.48723269103, 34263.82868085644, 25939.610905836806, 26245.21264362072, 26437.0, 26601.467970640864, 26616.467670646867], "value": 16792.939114840647, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.5167785234899, 380.24331580155484, 383.2105861924436, 396.21351617040153, 401.35382034923765, 15902.84097159028, 17266.740998885027, 17596.20817063232, 17662.64674706505, 17710.380136695218, 16963.491095267163, 17092.82907170931, 17579.64840703185, 17803.0, 17851.10744462778, 5234.057869583483, 5365.543928766059, 5386.542143917772, 5408.4050754416985, 5412.810551630694, 3784.5080139581814, 5956.791512297071, 6267.4045965633195, 6273.968630156843, 6326.177596912418, 6211.751529938797, 6292.339304373044, 6312.49500039998, 6334.936650633481, 6343.6193828370215, 6256.280527739277, 6276.5292603054495, 6298.149749783766, 6304.810855674337, 6326.968365158168, 5395.919061214085, 5544.140658197985, 5566.165075238706, 5596.4403559644115, 5602.075657516505, 21270.89364553183, 21437.785622143736, 21924.561508769893, 22010.88994555033, 22185.55958844526, 1747.7378393240988, 1883.303177824214, 1989.8607097503182, 2103.379503046605, 2138.5829763196184, 9351.485668288242, 9586.712398628053, 9766.169875560587, 11111.888881111247, 13952.581422557238, 1777.7511148439228, 1800.1629242402214, 1813.3925135079764, 1868.813118688134, 1877.1271358818078, 69009.65495172492, 72628.18429539251, 73184.0, 73513.63243183804, 73682.63158684225, 9788.314817962817, 10156.644517441853, 10161.54273057714, 10194.592216311265, 10551.261411701107, 13067.281299528428, 13165.67085822843, 13269.601911942656, 13292.0, 13310.733785324433, 6840.897386539106, 6862.725490980305, 6891.27641597635, 6922.619255940972, 7139.750108746169, 6445.871082578416, 6499.220093588705, 6621.702023408958, 6653.800385988428, 6657.267700552935, 3825.4261860721112, 4193.287141186006, 4347.543507931685, 4379.540148284448, 4541.364209010741, 1732.523556022104, 1850.3901605603212, 1855.1002763659615, 1859.711744679577, 1880.4734674291221, 832.4963397144761, 870.3298460185622, 892.3218354050838, 908.1644886704248, 956.6125719083782, 16762.161891905598, 17264.568385790455, 17315.0, 17451.825481745273, 17693.91153044252, 850.9787255318666, 872.5026734761252, 877.8902637170354, 885.8936927568733, 886.8758373827669, 9750.609975600897, 9770.853437198448, 9826.80346393068, 9865.950670246746, 9907.0, 394152.0, 394305.0, 397856.0, 405431.70125643373, 408085.0, 74447.25552744404, 74832.25167748253, 75292.62353688307, 76778.0, 77128.0, 880.6213328268777, 899.8245342158348, 904.9547522623842, 934.5047125023748, 946.947917864524, 15809.051456912623, 15981.200939953189, 16011.919940400223, 16118.435854745028, 16154.596135096717, 36874.8156259217, 37676.81161594175, 37732.24535509329, 38129.23741525209, 38285.61714382932, 49202.26196606982, 50265.24602130898, 54886.45113548813, 55961.72019139878, 56496.15255771085, 7711.151773305044, 7774.144844067035, 8036.959815200887, 8139.674413023649, 8291.419600627898, 9006.774830629287, 11888.34614096233, 12721.427535760728, 12727.681807954876, 12830.10189286741, 4671.43942726875, 8399.622017009127, 10328.896711033094, 10711.94644026775, 10903.56385744593, 10285.331453455501, 10477.790444190921, 10655.89344106549, 10900.364945258274, 11086.778264434828, 9399.671011514563, 10036.447995360326, 10045.849312260469, 10094.697159085239, 10293.485325733833, 7849.4897831640765, 7864.882026769488, 7985.08171560278, 8098.271155596025, 8125.79685507867, 10576.84134737995, 10645.059100718565, 10740.087092597218, 10921.726956825825, 11150.944245278723], "value": 8430.443005907948, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1384.0450089438286, 1421.502474134053, 1515.4998850379377, 1690.7379356199792, 1706.8463838254554, 7038.753643622462, 7573.9621301893485, 7622.352100071486, 8154.796130096751, 8185.631646575904, 7911.881321780178, 7955.363570914327, 7970.880436793453, 8024.438289319735, 8037.27664510194, 2202.0861342542867, 2242.473018840571, 2243.8653680779125, 2245.045855511409, 2250.3473992542145, 2059.6292667319876, 2061.3506745375234, 2113.6723807809813, 2115.2913773885766, 2119.2794449887037, 2182.978170218293, 2207.514346843692, 2210.9447263818374, 2215.789499997498, 2217.911283548664, 2049.784772598878, 2050.354138446392, 2062.556550341676, 2066.0, 2070.0, 2121.734783152106, 2147.624165770984, 2164.1127137873555, 2175.3039027511204, 2176.5320456101854, 8024.277814996678, 8034.718784842561, 8043.718469853586, 8062.758117256433, 8094.919050809475, 4677.298405239241, 4792.161371759928, 4808.182608956451, 4808.855734327975, 4821.325014497973, 2825.70330115337, 2869.0532124398896, 2903.274181454636, 2916.300087978891, 2983.671796102427, 876.1063715010654, 899.2131884600974, 930.4510338900013, 944.2351695126969, 945.0738276489079, 10780.73048173794, 10822.0, 10910.5090270938, 10915.672529824118, 10916.563337466492, 4087.8160482777753, 4161.188568229166, 4278.507971583245, 4291.141771645684, 4413.646908247332, 9329.673461428818, 9339.392939458914, 9421.62313507452, 9425.76435589102, 9427.245820334494, 4626.074785043005, 4641.164590373698, 4658.534146585314, 4659.883502912454, 4664.743439110814, 3697.131174174067, 4173.269677806433, 4196.538380778112, 4221.894452638709, 4367.847125350598, 3623.7644553103964, 3652.543432070991, 3701.4632878232505, 3783.5838057813617, 3785.413260944558, 1176.5117476247433, 1182.763447310524, 1189.4885199364358, 1199.9280043197436, 1207.5773479282357, 732.4341822387237, 746.7573038762424, 805.4120492040726, 874.9737507874773, 893.1291990309396, 5487.149491828773, 5580.2466666999435, 5594.580406469531, 5780.826575202751, 5805.88388232233, 853.9231469167805, 875.6672464463591, 915.8168366326761, 922.5064590444081, 935.8783358163531, 3680.116771974707, 3811.1805961718364, 3843.423486476995, 3881.4177873319227, 3906.4726261954274, 9472.194863436547, 9784.217262619115, 9796.412215267106, 9844.606215751433, 9845.852312215322, 9752.853707194397, 9772.853407198756, 9774.315797894222, 9787.0, 9829.901700982899, 7386.926130738731, 7393.8151546211775, 7551.169371369145, 7583.582902940391, 7583.848323033619, 5477.370102438112, 5498.45015498447, 5501.174823776306, 5555.416681248573, 5657.066584013592, 9211.631534738535, 9219.17027467531, 9270.907290927275, 9308.301877359361, 9317.86023209639, 8969.684862408283, 9394.577244023898, 9405.764855878659, 9422.670206542738, 9442.291828113057, 6102.481289090477, 6702.396784289437, 6886.8622627548175, 6938.167419909643, 7088.0785497884945, 7674.6162691864065, 7744.8451030980195, 7789.493682910593, 7790.961045194737, 7823.530588164728, 6709.664516774239, 6753.898691519729, 6825.829354266183, 6834.282400347892, 7031.507794454339, 6795.966020169867, 6845.657717114224, 6903.827404314932, 6906.171259448898, 6970.51206415546, 6554.868902622016, 6566.24488183865, 6567.9671601641685, 6572.539922205399, 6628.5028622852515, 4597.931031034604, 4603.0, 4620.422447194101, 4760.024195040078, 4848.951510484992, 4738.739369334582, 4763.3807605011125, 4811.1820990431015, 4864.6594738369395, 4915.754212289443], "value": 4220.683318202359, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.5612861351041, 303.5037713338691, 306.08175473579263, 309.0928125950337, 311.8503118503119, 4996.351204102646, 5045.470225626307, 5064.215046667763, 5066.518680725334, 5083.6441449098575, 4980.576650984662, 4984.37695288089, 5002.649814512985, 5007.549320561149, 5053.242013697947, 3724.459953306769, 3797.696184305249, 3918.1771827916173, 3930.8380390785096, 3934.193490334489, 3901.590333015021, 3916.5300163980364, 3917.6278253565865, 3920.4315374270714, 3924.156306394125, 3915.2169566086754, 3916.921661566767, 3919.1181984053646, 3922.411638254256, 3923.8234279457492, 3830.8276127574327, 3896.8441262349756, 3915.432262321976, 3925.725199236055, 3935.8622448214173, 3429.5198672185916, 3459.411899976985, 3466.584009918826, 3467.3412051710093, 3470.548828652259, 4869.269609558559, 4876.171050921352, 4891.388576427947, 4894.36373271476, 4906.31311616374, 4332.458442694663, 4467.749030271497, 4478.57453541913, 4497.482789479219, 4518.796654150571, 5181.689098654055, 5226.372835259755, 5250.44870288618, 5258.710770907599, 5267.183586544092, 3734.9439758403646, 3753.2118255166447, 3758.1168425420005, 3758.248350329945, 3760.7179461540495, 5328.815185773814, 5490.368607610136, 5491.0, 5494.0, 5494.697791621459, 3788.962110378916, 3822.6559609635265, 3826.617338266151, 3850.114473671071, 3859.9421008684894, 3886.4753258309765, 3894.299026175259, 3903.0, 3906.1015966327905, 3909.4526766252748, 4369.694121411534, 4428.645708343389, 4448.399466072104, 4450.866474005785, 4464.196444639996, 5009.248612708123, 5198.584113270929, 5205.505476979681, 5223.955208958224, 5234.450382709761, 1335.2922950835878, 1337.806018127366, 1345.7375811716622, 1346.145197799385, 1349.8582648821928, 837.899452065756, 873.6942070275353, 874.0909454167721, 887.8890138732659, 892.4199270474244, 4510.774461276923, 4643.515719090338, 4645.6980296280635, 4661.860144195612, 4675.509071547506, 5382.838514844482, 5448.863778405572, 5449.3188351456065, 5457.399686034533, 5461.617686761889, 4454.1982443159895, 4665.160271151225, 4676.0, 4687.20317546018, 4696.765161741968, 2884.5240535311436, 2898.4782739107163, 2914.2422970027947, 2914.810537315068, 2916.3292442737866, 5123.410807757081, 5124.897502050013, 5127.6154288428515, 5134.563562097189, 5152.330197074356, 5361.488225212492, 5528.253685752452, 5533.557315414757, 5541.362743284493, 5576.498115169654, 5036.899262014813, 5070.0, 5111.182210846247, 5120.974395128001, 5131.102057139986, 5407.891842163213, 5421.484958928895, 5443.210734443563, 5444.945550544602, 5446.618736688552, 5102.69383836971, 5272.340957380327, 5297.2583838263445, 5317.813876514459, 5328.600354973315, 5063.620228482952, 5077.019962214813, 5078.771455284447, 5089.491050895029, 5103.413107492686, 3866.6133386662236, 3883.223355328889, 3885.4754608128674, 3890.0, 3902.6097390261884, 5188.9740551297, 5371.677699338053, 5379.731013449234, 5410.3507579090765, 5427.864303392289, 5143.431253467728, 5148.459411761711, 5206.791728330824, 5220.381681678692, 5220.451852555579, 5181.2746215529105, 5222.206119725928, 5230.686158830483, 5236.5548928339995, 5260.947390526046, 4906.239532872411, 5143.0, 5152.948470515397, 5163.09645811989, 5163.948360516497, 5053.29253904461, 5128.538431541179, 5292.7353632319, 5314.3091398117995, 5324.908393779188, 5174.525260300947, 5191.714455704972, 5196.558292545176, 5201.479852014768, 5204.1673332266655], "value": 3958.377403150486, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [627.3162253144072, 631.5200447659777, 639.2041907824758, 710.8151880511069, 732.3445516262947, 11823.172377933537, 11930.701732456693, 12632.68418289542, 12941.41763620637, 12967.157134786232, 12957.28734919579, 13084.869151308509, 13118.73762524749, 13122.0, 13148.145370550907, 613.6900865063159, 750.2984709296798, 761.5126319155745, 779.1818590479974, 780.7891869195314, 775.1202385292677, 776.3401109057285, 777.6966982876683, 777.7277952716561, 779.5985067690144, 809.8825670277806, 812.0012384766741, 818.0633175014605, 818.2267756969666, 820.0937963550281, 800.6157044618616, 801.3989507869098, 803.8432505661399, 807.039622848811, 808.1716240853173, 588.0532342927883, 592.3720855892724, 592.48453845155, 593.5844908564022, 593.7061154728394, 12608.74782504354, 12691.0, 12697.873021269761, 12702.0, 12755.234685918875, 12889.613311600573, 13129.0, 13234.27211503367, 13349.199048057148, 13377.398017089254, 10348.120409765179, 10362.844557331646, 10367.274290799647, 10408.583656653725, 10653.360798352123, 3214.276787722767, 3224.7097761201603, 3269.444194486919, 3326.06870076379, 3344.3311337732553, 60160.69919650374, 60707.089393659575, 61348.0, 61461.0, 61635.0, 10381.169506439466, 10445.68662940113, 10503.842442363371, 10537.525811338508, 10549.47252637365, 16481.505554833133, 17014.829851701572, 17021.65956680884, 17820.0, 18828.246870125316, 7040.92959070413, 7047.330503602149, 7118.216996130422, 7121.501494895308, 7169.928300716926, 3648.945265821015, 3711.7030637548933, 3713.4801127842125, 3731.514903062639, 3810.6760925321105, 2750.5324094903913, 2839.162447078117, 2846.0465743975587, 2847.2027832207013, 2855.4431885782487, 500.3820281951787, 501.58869726824383, 502.9899402011939, 507.2771300896282, 521.0802932823569, 532.2149829002268, 612.2530512774408, 618.5175563060819, 621.1614320667063, 630.6815058395481, 7836.921630783733, 7980.920190798134, 8080.959595201986, 8227.753167404988, 8333.8333233335, 580.9687804147671, 584.2463222443085, 614.0727501472808, 635.0284065379976, 646.8285904235381, 3929.7052721046034, 4026.3970430522827, 4059.6346328830546, 4190.790460476964, 4217.093324935154, 92505.0, 94196.0, 95277.52361238288, 95506.52246738861, 96644.51677741707, 64264.0, 66161.66919165374, 66687.66656166785, 84743.5762821182, 85070.0, 54854.45145548494, 69678.30321696718, 72199.6390018057, 73067.63466182635, 75937.58280877373, 8789.07714689974, 8797.47215167092, 8822.382433229612, 9098.954505227697, 9291.256699464162, 41259.587404125574, 41530.79234603808, 41545.0, 41552.96117597084, 42041.0, 54216.45783542114, 58104.70947645404, 58310.708446457495, 58615.4138458627, 59055.0, 11224.38265895351, 11250.212485125963, 11408.087353011904, 11423.371714555447, 11458.885411146115, 12912.806307905577, 12979.675508112372, 12983.221006739626, 13486.12340197884, 13691.110077844909, 11264.887351126385, 12309.0, 12411.317377544321, 12571.434285456993, 12577.119601627799, 12162.0, 12221.694457638274, 12449.066320026215, 13079.280639564915, 13106.082574219714, 11370.94314528422, 11592.768144637228, 11672.941635291769, 11942.283462992249, 12325.322107284186, 9801.80396392054, 9818.263630227904, 10270.589176433157, 10386.532606032897, 10483.58065677395, 9531.952340238531, 9940.204783617437, 9972.252081093802, 10057.195424365887, 10072.143867771321], "value": 6519.37534449358, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1581.1000000000004, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 117.0, 108.0, 115.0, 114.0, 114.0, 116.0, 114.0, 114.0, 115.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 124.0, 153.0, 191.0, 128.0, 148.0, 153.0, 124.0, 187.0, 128.0], "value": 148.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 166.0, 165.0, 175.0, 165.0, 163.0, 162.0, 164.0, 162.0, 162.0], "value": 165.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 158.0, 77.0, 77.0, 76.0, 76.0, 153.0, 76.0], "value": 92.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 156.0, 86.0, 86.0, 86.0, 147.0, 85.0, 86.0, 132.0], "value": 103.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 118.0, 118.0, 118.0, 117.0, 118.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 151.0, 148.0, 148.0, 148.0, 148.0, 147.0, 147.0, 147.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 68.0, 67.0, 65.0, 64.0, 63.0, 64.0, 65.0, 64.0], "value": 64.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 71.0, 70.0, 69.0, 70.0, 71.0, 70.0, 75.0, 72.0], "value": 70.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 86.0, 79.0, 84.0, 85.0, 84.0, 80.0, 80.0, 83.0, 79.0], "value": 82.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 128.0, 132.0, 145.0, 140.0, 142.0, 141.0, 140.0, 172.0, 139.0], "value": 141.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 172.0, 169.0, 167.0, 167.0, 167.0, 180.0, 166.0, 167.0, 167.0], "value": 169.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 69.0, 69.0, 67.0, 70.0, 67.0, 68.0, 70.0, 66.0, 67.0], "value": 68.5, "unit": "score"}]}]} 20:41:49 INFO - Return code: 0 20:41:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:41:49 ERROR - # TBPL SUCCESS # 20:41:49 INFO - Running post-action listener: _resource_record_post_action 20:41:49 INFO - ##### 20:41:49 INFO - ##### Finished run-tests step (success) 20:41:49 INFO - ##### 20:41:49 INFO - Running post-run listener: _resource_record_post_run 20:41:49 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 0; Write bytes: 536670208; Read time: 0; Write time: 376796 20:41:49 INFO - TinderboxPrint: CPU usage
13.3% 20:41:49 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 20:41:49 INFO - TinderboxPrint: I/O write bytes / time
536,670,208 / 376,796 20:41:49 INFO - TinderboxPrint: CPU idle
8,279.1 (86.7%) 20:41:49 INFO - TinderboxPrint: CPU user
1,218.7 (12.8%) 20:41:49 INFO - TinderboxPrint: Swap in / out
0 / 0 20:41:49 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 247492608; Read time: 0; Write time: 220528 20:41:49 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 289177600; Read time: 0; Write time: 156268 20:41:50 INFO - Running post-run listener: _upload_blobber_files 20:41:50 INFO - Blob upload gear active. 20:41:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:41:50 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:41:50 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:41:50 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:41:50 INFO - (blobuploader) - INFO - Open directory for files ... 20:41:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:41:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:41:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:41:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:41:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:41:51 INFO - (blobuploader) - INFO - Done attempting. 20:41:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:41:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:41:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:41:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:41:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:41:52 INFO - (blobuploader) - INFO - Done attempting. 20:41:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:41:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:41:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:42:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:42:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:42:06 INFO - (blobuploader) - INFO - Done attempting. 20:42:06 INFO - (blobuploader) - INFO - Iteration through files over. 20:42:06 INFO - Return code: 0 20:42:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:42:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:42:06 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/5d70606f299128a0a50fb4fca4f5d1881f0f7792e75be6a5988c93adabd971deed0b4086a4a0389145483ea1a18aa95b32d9a3488c536890c11117318fb10f6a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2cf565ec59a4383c998cc661800016ce80e56c3bbf42ec2cabd5cabafe6efb4146ba08f0fb918f27b7dfb8e14c4f95137a01ec503f4f0fb960b9bf827b30066b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b31321c289292593ddefc7bdfd4cd47bb1e6eefbe6715ae3f53cd918e6c5eef99c3fb21a9c8dbc0231984c5a689706902ecaba6c40cda379bbef1773483a2305"} 20:42:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:42:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:42:06 INFO - Contents: 20:42:06 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/5d70606f299128a0a50fb4fca4f5d1881f0f7792e75be6a5988c93adabd971deed0b4086a4a0389145483ea1a18aa95b32d9a3488c536890c11117318fb10f6a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2cf565ec59a4383c998cc661800016ce80e56c3bbf42ec2cabd5cabafe6efb4146ba08f0fb918f27b7dfb8e14c4f95137a01ec503f4f0fb960b9bf827b30066b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b31321c289292593ddefc7bdfd4cd47bb1e6eefbe6715ae3f53cd918e6c5eef99c3fb21a9c8dbc0231984c5a689706902ecaba6c40cda379bbef1773483a2305"} 20:42:06 INFO - Running post-run listener: copy_logs_to_upload_dir 20:42:06 INFO - Copying logs to upload dir... 20:42:06 INFO - mkdir: /builds/slave/test/build/upload/logs 20:42:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.744639 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-07-18 20:42:05.802076) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 20:42:05.805351) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1468898469.589196-1815931882 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/5d70606f299128a0a50fb4fca4f5d1881f0f7792e75be6a5988c93adabd971deed0b4086a4a0389145483ea1a18aa95b32d9a3488c536890c11117318fb10f6a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2cf565ec59a4383c998cc661800016ce80e56c3bbf42ec2cabd5cabafe6efb4146ba08f0fb918f27b7dfb8e14c4f95137a01ec503f4f0fb960b9bf827b30066b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b31321c289292593ddefc7bdfd4cd47bb1e6eefbe6715ae3f53cd918e6c5eef99c3fb21a9c8dbc0231984c5a689706902ecaba6c40cda379bbef1773483a2305"} build_url:https://queue.taskcluster.net/v1/task/Up5-wcboQyWGb8w0HJgM1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011381 build_url: 'https://queue.taskcluster.net/v1/task/Up5-wcboQyWGb8w0HJgM1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/5d70606f299128a0a50fb4fca4f5d1881f0f7792e75be6a5988c93adabd971deed0b4086a4a0389145483ea1a18aa95b32d9a3488c536890c11117318fb10f6a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2cf565ec59a4383c998cc661800016ce80e56c3bbf42ec2cabd5cabafe6efb4146ba08f0fb918f27b7dfb8e14c4f95137a01ec503f4f0fb960b9bf827b30066b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b31321c289292593ddefc7bdfd4cd47bb1e6eefbe6715ae3f53cd918e6c5eef99c3fb21a9c8dbc0231984c5a689706902ecaba6c40cda379bbef1773483a2305"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 20:42:05.832945) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 20:42:05.833610) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1468898469.589196-1815931882 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004491 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 20:42:05.917126) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 20:42:05.917839) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 20:42:05.918483) ========= ========= Total master_lag: 0.17 =========