builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-019 starttime: 1467400381.06 results: success (0) buildid: 20160701114222 builduid: 52554bcbb870440e8f09a0838b695bb1 revision: 3bde90c197be1b2f60db5c3d5127d69950ba3b2f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-01 12:13:01.057230) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-01 12:13:01.057759) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-01 12:13:01.058244) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-01 12:13:01.073437) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 12:13:01.073771) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1467400282.177338-1438599735 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-01 12:13:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.7M=0s 2016-07-01 12:13:01 (46.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.113268 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 12:13:01.201861) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 12:13:01.202244) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1467400282.177338-1438599735 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016755 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 12:13:01.252604) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-07-01 12:13:01.252976) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3bde90c197be1b2f60db5c3d5127d69950ba3b2f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 3bde90c197be1b2f60db5c3d5127d69950ba3b2f --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=78329bfc0fd5309db0a6e0ac000001b4-1467400282.177338-1438599735 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-01 12:13:01,544 truncating revision to first 12 chars 2016-07-01 12:13:01,544 Setting DEBUG logging. 2016-07-01 12:13:01,544 attempt 1/10 2016-07-01 12:13:01,545 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3bde90c197be?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-01 12:13:03,716 unpacking tar archive at: fx-team-3bde90c197be/testing/mozharness/ program finished with exit code 0 elapsedTime=2.530344 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-07-01 12:13:03.808633) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-01 12:13:03.808985) ========= script_repo_revision: 3bde90c197be1b2f60db5c3d5127d69950ba3b2f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-01 12:13:03.809621) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-01 12:13:03.809901) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-01 12:13:03.826194) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-07-01 12:13:03.826525) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-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=78329bfc0fd5309db0a6e0ac000001b4-1467400282.177338-1438599735 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:13:04 INFO - MultiFileLogger online at 20160701 12:13:04 in /builds/slave/test 12:13:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 12:13:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:13:04 INFO - {'append_to_log': False, 12:13:04 INFO - 'base_work_dir': '/builds/slave/test', 12:13:04 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 12:13:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:13:04 INFO - 'branch': 'Fx-Team-Non-PGO', 12:13:04 INFO - 'buildbot_json_path': 'buildprops.json', 12:13:04 INFO - 'config_files': ('talos/linux_config.py',), 12:13:04 INFO - 'default_actions': ('clobber', 12:13:04 INFO - 'read-buildbot-config', 12:13:04 INFO - 'download-and-extract', 12:13:04 INFO - 'populate-webroot', 12:13:04 INFO - 'create-virtualenv', 12:13:04 INFO - 'install', 12:13:04 INFO - 'run-tests'), 12:13:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:13:04 INFO - 'download_minidump_stackwalk': True, 12:13:04 INFO - 'download_symbols': 'ondemand', 12:13:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:13:04 INFO - 'tooltool.py': '/tools/tooltool.py', 12:13:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:13:04 INFO - '/tools/misc-python/virtualenv.py')}, 12:13:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:13:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:13:04 INFO - 'installer_path': 'installer.exe', 12:13:04 INFO - 'log_level': 'info', 12:13:04 INFO - 'log_name': 'talos', 12:13:04 INFO - 'log_to_console': True, 12:13:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:13:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:13:04 INFO - 'opt_config_files': (), 12:13:04 INFO - 'pip_index': False, 12:13:04 INFO - 'sps_profile': False, 12:13:04 INFO - 'sps_profile_interval': 0, 12:13:04 INFO - 'suite': 'dromaeojs', 12:13:04 INFO - 'system_bits': '32', 12:13:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:13:04 INFO - 'title': 'talos-linux64-ix-019', 12:13:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:13:04 INFO - 'use_talos_json': True, 12:13:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:13:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:13:04 INFO - 'work_dir': 'build'} 12:13:04 INFO - ##### 12:13:04 INFO - ##### Running clobber step. 12:13:04 INFO - ##### 12:13:04 INFO - Running pre-action listener: _resource_record_pre_action 12:13:04 INFO - Running main action method: clobber 12:13:04 INFO - rmtree: /builds/slave/test/build 12:13:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:13:04 INFO - Running post-action listener: _resource_record_post_action 12:13:04 INFO - ##### 12:13:04 INFO - ##### Finished clobber step (success) 12:13:04 INFO - ##### 12:13:04 INFO - ##### 12:13:04 INFO - ##### Running read-buildbot-config step. 12:13:04 INFO - ##### 12:13:04 INFO - Running pre-action listener: _resource_record_pre_action 12:13:04 INFO - Running main action method: read_buildbot_config 12:13:04 INFO - Using buildbot properties: 12:13:04 INFO - { 12:13:04 INFO - "project": "", 12:13:04 INFO - "product": "firefox", 12:13:04 INFO - "script_repo_revision": "production", 12:13:04 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 12:13:04 INFO - "repository": "", 12:13:04 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 12:13:04 INFO - "buildid": "20160701114222", 12:13:04 INFO - "pgo_build": "False", 12:13:04 INFO - "basedir": "/builds/slave/test", 12:13:04 INFO - "buildnumber": 1920, 12:13:04 INFO - "slavename": "talos-linux64-ix-019", 12:13:04 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:13:04 INFO - "platform": "ubuntu64_hw", 12:13:04 INFO - "scheduler": "tests-fx-team-linux64-talos", 12:13:04 INFO - "branch": "fx-team", 12:13:04 INFO - "repo_path": "integration/fx-team", 12:13:04 INFO - "revision": "3bde90c197be1b2f60db5c3d5127d69950ba3b2f", 12:13:04 INFO - "stage_platform": "linux64", 12:13:04 INFO - "builduid": "52554bcbb870440e8f09a0838b695bb1", 12:13:04 INFO - "slavebuilddir": "test" 12:13:04 INFO - } 12:13:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/BDYG5pMWQrOZYLexkHRKKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 12:13:04 INFO - Running post-action listener: _resource_record_post_action 12:13:04 INFO - ##### 12:13:04 INFO - ##### Finished read-buildbot-config step (success) 12:13:04 INFO - ##### 12:13:04 INFO - ##### 12:13:04 INFO - ##### Running download-and-extract step. 12:13:04 INFO - ##### 12:13:04 INFO - Running pre-action listener: _resource_record_pre_action 12:13:04 INFO - Running main action method: download_and_extract 12:13:04 INFO - mkdir: /builds/slave/test/build/tests 12:13:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:13:04 INFO - https://queue.taskcluster.net/v1/task/BDYG5pMWQrOZYLexkHRKKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:13:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BDYG5pMWQrOZYLexkHRKKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:13:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BDYG5pMWQrOZYLexkHRKKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:13:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BDYG5pMWQrOZYLexkHRKKQ/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 12:13:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BDYG5pMWQrOZYLexkHRKKQ/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 12:13:05 INFO - Downloaded 1361 bytes. 12:13:05 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:13:05 INFO - Using the following test package requirements: 12:13:05 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 12:13:05 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:13:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:13:05 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:13:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:13:05 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:13:05 INFO - u'jsshell-linux-x86_64.zip'], 12:13:05 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:13:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:13:05 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 12:13:05 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:13:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:13:05 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:13:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:13:05 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:13:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:13:05 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:13:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:13:05 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:13:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:13:05 INFO - https://queue.taskcluster.net/v1/task/BDYG5pMWQrOZYLexkHRKKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:13:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BDYG5pMWQrOZYLexkHRKKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:13:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BDYG5pMWQrOZYLexkHRKKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:13:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BDYG5pMWQrOZYLexkHRKKQ/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 12:13:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BDYG5pMWQrOZYLexkHRKKQ/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 12:13:06 INFO - Downloaded 22704123 bytes. 12:13:06 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'] 12:13:06 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 12:13:07 INFO - Return code: 0 12:13:07 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 12:13:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:13:07 INFO - https://queue.taskcluster.net/v1/task/BDYG5pMWQrOZYLexkHRKKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:13:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BDYG5pMWQrOZYLexkHRKKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:13:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BDYG5pMWQrOZYLexkHRKKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:13:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BDYG5pMWQrOZYLexkHRKKQ/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 12:13:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BDYG5pMWQrOZYLexkHRKKQ/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 12:13:12 INFO - Downloaded 22704123 bytes. 12:13:12 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'] 12:13:12 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 12:13:13 INFO - Return code: 0 12:13:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:13:13 INFO - https://queue.taskcluster.net/v1/task/BDYG5pMWQrOZYLexkHRKKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:13:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BDYG5pMWQrOZYLexkHRKKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 12:13:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BDYG5pMWQrOZYLexkHRKKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 12:13:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BDYG5pMWQrOZYLexkHRKKQ/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 12:13:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BDYG5pMWQrOZYLexkHRKKQ/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 12:13:14 INFO - Downloaded 14405242 bytes. 12:13:14 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'] 12:13:14 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 12:13:15 INFO - Return code: 0 12:13:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:13:15 INFO - https://queue.taskcluster.net/v1/task/BDYG5pMWQrOZYLexkHRKKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:13:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BDYG5pMWQrOZYLexkHRKKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:13:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BDYG5pMWQrOZYLexkHRKKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:13:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BDYG5pMWQrOZYLexkHRKKQ/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 12:13:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BDYG5pMWQrOZYLexkHRKKQ/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 12:13:16 INFO - Downloaded 56455267 bytes. 12:13:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BDYG5pMWQrOZYLexkHRKKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:13:16 INFO - mkdir: /builds/slave/test/properties 12:13:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:13:16 INFO - Writing to file /builds/slave/test/properties/build_url 12:13:16 INFO - Contents: 12:13:16 INFO - build_url:https://queue.taskcluster.net/v1/task/BDYG5pMWQrOZYLexkHRKKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:13:17 INFO - Running post-action listener: _resource_record_post_action 12:13:17 INFO - Running post-action listener: set_extra_try_arguments 12:13:17 INFO - ##### 12:13:17 INFO - ##### Finished download-and-extract step (success) 12:13:17 INFO - ##### 12:13:17 INFO - ##### 12:13:17 INFO - ##### Running populate-webroot step. 12:13:17 INFO - ##### 12:13:17 INFO - Running pre-action listener: _resource_record_pre_action 12:13:17 INFO - Running main action method: populate_webroot 12:13:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:13:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:13:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:13:17 INFO - '--tppagecycles', 12:13:17 INFO - '7'], 12:13:17 INFO - 'tests': ['tsvgm']}}, 12:13:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:13:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:13:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:13:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:13:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:13:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:13:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:13:17 INFO - 'talos_options': ['--disable-e10s'], 12:13:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:13:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:13:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:13:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:13:17 INFO - 'talos_options': ['--disable-e10s'], 12:13:17 INFO - 'tests': ['damp', 'tps']}, 12:13:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:13:17 INFO - 'tests': ['damp', 'tps']}, 12:13:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:13:17 INFO - 'tests': ['dromaeo_dom']}, 12:13:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:13:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:13:17 INFO - 'tests': ['basic_compositor_video']}, 12:13:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:13:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:13:17 INFO - 'tests': ['a11yr', 12:13:17 INFO - 'ts_paint', 12:13:17 INFO - 'tpaint', 12:13:17 INFO - 'sessionrestore', 12:13:17 INFO - 'sessionrestore_no_auto_restore', 12:13:17 INFO - 'tabpaint']}, 12:13:17 INFO - 'other-e10s': {'tests': ['a11yr', 12:13:17 INFO - 'ts_paint', 12:13:17 INFO - 'tpaint', 12:13:17 INFO - 'sessionrestore', 12:13:17 INFO - 'sessionrestore_no_auto_restore', 12:13:17 INFO - 'tabpaint']}, 12:13:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:13:17 INFO - 'ts_paint', 12:13:17 INFO - 'tpaint', 12:13:17 INFO - 'sessionrestore', 12:13:17 INFO - 'sessionrestore_no_auto_restore', 12:13:17 INFO - 'tabpaint']}, 12:13:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:13:17 INFO - 'ts_paint', 12:13:17 INFO - 'tpaint', 12:13:17 INFO - 'sessionrestore', 12:13:17 INFO - 'sessionrestore_no_auto_restore', 12:13:17 INFO - 'tabpaint']}, 12:13:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:13:17 INFO - 'tests': ['a11yr', 12:13:17 INFO - 'ts_paint', 12:13:17 INFO - 'tpaint', 12:13:17 INFO - 'sessionrestore', 12:13:17 INFO - 'sessionrestore_no_auto_restore', 12:13:17 INFO - 'tabpaint']}, 12:13:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:13:17 INFO - 'tests': ['a11yr', 12:13:17 INFO - 'ts_paint', 12:13:17 INFO - 'tpaint', 12:13:17 INFO - 'sessionrestore', 12:13:17 INFO - 'sessionrestore_no_auto_restore', 12:13:17 INFO - 'tabpaint']}, 12:13:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:13:17 INFO - 'tests': ['tsvgx', 12:13:17 INFO - 'tsvgr_opacity', 12:13:17 INFO - 'tart', 12:13:17 INFO - 'tscrollx', 12:13:17 INFO - 'cart']}, 12:13:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:13:17 INFO - 'tsvgr_opacity', 12:13:17 INFO - 'tart', 12:13:17 INFO - 'tscrollx', 12:13:17 INFO - 'cart']}, 12:13:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:13:17 INFO - 'talos_options': ['--disable-e10s'], 12:13:17 INFO - 'tests': ['tp5o']}, 12:13:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:13:17 INFO - 'tests': ['tp5o']}, 12:13:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:13:17 INFO - 'talos_options': ['--disable-e10s', 12:13:17 INFO - '--xperf_path', 12:13:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:13:17 INFO - 'tests': ['tp5n']}, 12:13:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:13:17 INFO - 'talos_options': ['--xperf_path', 12:13:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:13:17 INFO - 'tests': ['tp5n']}}, 12:13:17 INFO - 'talos.zip': {'path': '', 12:13:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:13:17 INFO - Running post-action listener: _resource_record_post_action 12:13:17 INFO - ##### 12:13:17 INFO - ##### Finished populate-webroot step (success) 12:13:17 INFO - ##### 12:13:17 INFO - ##### 12:13:17 INFO - ##### Running create-virtualenv step. 12:13:17 INFO - ##### 12:13:17 INFO - Running pre-action listener: _resource_record_pre_action 12:13:17 INFO - Running main action method: create_virtualenv 12:13:17 INFO - Creating virtualenv /builds/slave/test/build/venv 12:13:17 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 12:13:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:13:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:13:17 INFO - Using real prefix '/usr' 12:13:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:13:17 INFO - Installing distribute.............................................................................................................................................................................................done. 12:13:19 INFO - Installing pip.................done. 12:13:19 INFO - Return code: 0 12:13:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:13:19 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')]} 12:13:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:13:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13:19 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')]} 12:13:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:13:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13:19 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 0x2966030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c27180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c253b0>, '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 0x2c262b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c26740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1467400282.177338-1438599735', '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 12:13:19 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 12:13:19 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 12:13:19 INFO - Using env: {'DISPLAY': ':0', 12:13:19 INFO - 'HOME': '/home/cltbld', 12:13:19 INFO - 'LANG': 'en_US.UTF-8', 12:13:19 INFO - 'LANGUAGE': 'en_US:en', 12:13:19 INFO - 'LOGNAME': 'cltbld', 12:13:19 INFO - 'MAIL': '/var/mail/cltbld', 12:13:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:13:19 INFO - 'MOZ_NO_REMOTE': '1', 12:13:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:13:19 INFO - 'NO_EM_RESTART': '1', 12:13:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:13:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:13:19 INFO - 'PWD': '/builds/slave/test', 12:13:19 INFO - 'SHELL': '/bin/bash', 12:13:19 INFO - 'SHLVL': '1', 12:13:19 INFO - 'TERM': 'linux', 12:13:19 INFO - 'TMOUT': '86400', 12:13:19 INFO - 'USER': 'cltbld', 12:13:19 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467400282.177338-1438599735', 12:13:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:13:19 INFO - '_': '/tools/buildbot/bin/python'} 12:13:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:13:20 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 12:13:20 INFO - Cleaning up... 12:13:20 INFO - Return code: 0 12:13:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:13: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')]} 12:13:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:13:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13: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')]} 12:13:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:13:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2966030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c27180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c253b0>, '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 0x2c262b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c26740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1467400282.177338-1438599735', '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 12:13:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 12:13:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:13:20 INFO - Using env: {'DISPLAY': ':0', 12:13:20 INFO - 'HOME': '/home/cltbld', 12:13:20 INFO - 'LANG': 'en_US.UTF-8', 12:13:20 INFO - 'LANGUAGE': 'en_US:en', 12:13:20 INFO - 'LOGNAME': 'cltbld', 12:13:20 INFO - 'MAIL': '/var/mail/cltbld', 12:13:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:13:20 INFO - 'MOZ_NO_REMOTE': '1', 12:13:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:13:20 INFO - 'NO_EM_RESTART': '1', 12:13:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:13:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:13:20 INFO - 'PWD': '/builds/slave/test', 12:13:20 INFO - 'SHELL': '/bin/bash', 12:13:20 INFO - 'SHLVL': '1', 12:13:20 INFO - 'TERM': 'linux', 12:13:20 INFO - 'TMOUT': '86400', 12:13:20 INFO - 'USER': 'cltbld', 12:13:20 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467400282.177338-1438599735', 12:13:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:13:20 INFO - '_': '/tools/buildbot/bin/python'} 12:13:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:13:20 INFO - Downloading/unpacking psutil>=3.1.1 12:13:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:13:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:13:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:13:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:13:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:13:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:13:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:13:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:13:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:13:22 INFO - Installing collected packages: psutil 12:13:22 INFO - Running setup.py install for psutil 12:13:22 INFO - building 'psutil._psutil_linux' extension 12:13:22 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 12:13:22 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 12:13:22 INFO - building 'psutil._psutil_posix' extension 12:13:22 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 12:13:22 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 12:13:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:13:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:13:22 INFO - Successfully installed psutil 12:13:22 INFO - Cleaning up... 12:13:22 INFO - Return code: 0 12:13:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:13:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 12:13:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:13:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 12:13:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:13:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2966030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c27180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c253b0>, '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 0x2c262b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c26740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1467400282.177338-1438599735', '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 12:13:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:13:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:13:22 INFO - Using env: {'DISPLAY': ':0', 12:13:22 INFO - 'HOME': '/home/cltbld', 12:13:22 INFO - 'LANG': 'en_US.UTF-8', 12:13:22 INFO - 'LANGUAGE': 'en_US:en', 12:13:22 INFO - 'LOGNAME': 'cltbld', 12:13:22 INFO - 'MAIL': '/var/mail/cltbld', 12:13:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:13:22 INFO - 'MOZ_NO_REMOTE': '1', 12:13:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:13:22 INFO - 'NO_EM_RESTART': '1', 12:13:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:13:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:13:22 INFO - 'PWD': '/builds/slave/test', 12:13:22 INFO - 'SHELL': '/bin/bash', 12:13:22 INFO - 'SHLVL': '1', 12:13:22 INFO - 'TERM': 'linux', 12:13:22 INFO - 'TMOUT': '86400', 12:13:22 INFO - 'USER': 'cltbld', 12:13:22 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467400282.177338-1438599735', 12:13:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:13:22 INFO - '_': '/tools/buildbot/bin/python'} 12:13:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:13:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:13:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:13:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:13:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:13:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:13:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:13:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:13:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:13:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:13:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:13:25 INFO - Installing collected packages: mozsystemmonitor 12:13:25 INFO - Running setup.py install for mozsystemmonitor 12:13:25 INFO - Successfully installed mozsystemmonitor 12:13:25 INFO - Cleaning up... 12:13:25 INFO - Return code: 0 12:13:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:13:25 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')]} 12:13:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:13:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13:25 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')]} 12:13:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:13:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13:25 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 0x2966030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c27180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c253b0>, '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 0x2c262b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c26740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1467400282.177338-1438599735', '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 12:13:25 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 12:13:25 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 12:13:25 INFO - Using env: {'DISPLAY': ':0', 12:13:25 INFO - 'HOME': '/home/cltbld', 12:13:25 INFO - 'LANG': 'en_US.UTF-8', 12:13:25 INFO - 'LANGUAGE': 'en_US:en', 12:13:25 INFO - 'LOGNAME': 'cltbld', 12:13:25 INFO - 'MAIL': '/var/mail/cltbld', 12:13:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:13:25 INFO - 'MOZ_NO_REMOTE': '1', 12:13:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:13:25 INFO - 'NO_EM_RESTART': '1', 12:13:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:13:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:13:25 INFO - 'PWD': '/builds/slave/test', 12:13:25 INFO - 'SHELL': '/bin/bash', 12:13:25 INFO - 'SHLVL': '1', 12:13:25 INFO - 'TERM': 'linux', 12:13:25 INFO - 'TMOUT': '86400', 12:13:25 INFO - 'USER': 'cltbld', 12:13:25 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467400282.177338-1438599735', 12:13:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:13:25 INFO - '_': '/tools/buildbot/bin/python'} 12:13:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:13:25 INFO - Downloading/unpacking jsonschema==2.5.1 12:13:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:13:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:13:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:13:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:13:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:13:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:13:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:13:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:13:27 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 12:13:27 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 12:13:27 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 12:13:27 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 12:13:27 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 12:13:27 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 12:13:27 INFO - Downloading functools32-3.2.3-2.tar.gz 12:13:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:13:27 INFO - warning: no files found matching '*.txt' 12:13:27 INFO - no previously-included directories found matching 'build' 12:13:27 INFO - no previously-included directories found matching 'dist' 12:13:27 INFO - no previously-included directories found matching '.git*' 12:13:27 INFO - Installing collected packages: jsonschema, functools32 12:13:27 INFO - Running setup.py install for functools32 12:13:27 INFO - warning: no files found matching '*.txt' 12:13:27 INFO - no previously-included directories found matching 'build' 12:13:27 INFO - no previously-included directories found matching 'dist' 12:13:27 INFO - no previously-included directories found matching '.git*' 12:13:27 INFO - Successfully installed jsonschema functools32 12:13:27 INFO - Cleaning up... 12:13:27 INFO - Return code: 0 12:13:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:13: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')]} 12:13:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:13:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13: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')]} 12:13:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:13:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13:27 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 0x2966030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c27180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c253b0>, '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 0x2c262b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c26740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1467400282.177338-1438599735', '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 12:13:27 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 12:13:27 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 12:13:27 INFO - Using env: {'DISPLAY': ':0', 12:13:27 INFO - 'HOME': '/home/cltbld', 12:13:27 INFO - 'LANG': 'en_US.UTF-8', 12:13:27 INFO - 'LANGUAGE': 'en_US:en', 12:13:27 INFO - 'LOGNAME': 'cltbld', 12:13:27 INFO - 'MAIL': '/var/mail/cltbld', 12:13:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:13:27 INFO - 'MOZ_NO_REMOTE': '1', 12:13:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:13:27 INFO - 'NO_EM_RESTART': '1', 12:13:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:13:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:13:27 INFO - 'PWD': '/builds/slave/test', 12:13:27 INFO - 'SHELL': '/bin/bash', 12:13:27 INFO - 'SHLVL': '1', 12:13:27 INFO - 'TERM': 'linux', 12:13:27 INFO - 'TMOUT': '86400', 12:13:27 INFO - 'USER': 'cltbld', 12:13:27 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467400282.177338-1438599735', 12:13:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:13:27 INFO - '_': '/tools/buildbot/bin/python'} 12:13:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:13:27 INFO - Downloading/unpacking blobuploader==1.2.4 12:13:27 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 12:13:27 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 12:13:27 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 12:13:27 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 12:13:27 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 12:13:27 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 12:13:29 INFO - Downloading blobuploader-1.2.4.tar.gz 12:13:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:13:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:13:29 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 12:13:29 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 12:13:29 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 12:13:29 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 12:13:29 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 12:13:29 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 12:13:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:13:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:13:30 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 12:13:30 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 12:13:30 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 12:13:30 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 12:13:30 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 12:13:30 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 12:13:30 INFO - Downloading docopt-0.6.1.tar.gz 12:13:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:13:30 INFO - Installing collected packages: blobuploader, requests, docopt 12:13:30 INFO - Running setup.py install for blobuploader 12:13:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:13:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:13:30 INFO - Running setup.py install for requests 12:13:31 INFO - Running setup.py install for docopt 12:13:31 INFO - Successfully installed blobuploader requests docopt 12:13:31 INFO - Cleaning up... 12:13:31 INFO - Return code: 0 12:13:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:13:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:13:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:13:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:13:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:13:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13:31 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 0x2966030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c27180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c253b0>, '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 0x2c262b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c26740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1467400282.177338-1438599735', '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 12:13:31 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 12:13:31 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 12:13:31 INFO - Using env: {'DISPLAY': ':0', 12:13:31 INFO - 'HOME': '/home/cltbld', 12:13:31 INFO - 'LANG': 'en_US.UTF-8', 12:13:31 INFO - 'LANGUAGE': 'en_US:en', 12:13:31 INFO - 'LOGNAME': 'cltbld', 12:13:31 INFO - 'MAIL': '/var/mail/cltbld', 12:13:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:13:31 INFO - 'MOZ_NO_REMOTE': '1', 12:13:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:13:31 INFO - 'NO_EM_RESTART': '1', 12:13:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:13:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:13:31 INFO - 'PWD': '/builds/slave/test', 12:13:31 INFO - 'SHELL': '/bin/bash', 12:13:31 INFO - 'SHLVL': '1', 12:13:31 INFO - 'TERM': 'linux', 12:13:31 INFO - 'TMOUT': '86400', 12:13:31 INFO - 'USER': 'cltbld', 12:13:31 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467400282.177338-1438599735', 12:13:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:13:31 INFO - '_': '/tools/buildbot/bin/python'} 12:13:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:13:31 INFO - Running setup.py (path:/tmp/pip-EkUMbT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:13:31 INFO - Running setup.py (path:/tmp/pip-awjfwW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:13:31 INFO - Running setup.py (path:/tmp/pip-5ZnU5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:13:31 INFO - Running setup.py (path:/tmp/pip-bfl3Bk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:13:31 INFO - Running setup.py (path:/tmp/pip-SKWIDV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:13:31 INFO - Running setup.py (path:/tmp/pip-F9ek7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:13:31 INFO - Running setup.py (path:/tmp/pip-fk8a3g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:13:31 INFO - Running setup.py (path:/tmp/pip-5aU2iD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:13:32 INFO - Running setup.py (path:/tmp/pip-pOFdMT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:13:32 INFO - Running setup.py (path:/tmp/pip-Dsd9pK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:13:32 INFO - Running setup.py (path:/tmp/pip-m52H6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:13:32 INFO - Running setup.py (path:/tmp/pip-uJiZq2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:13:32 INFO - Running setup.py (path:/tmp/pip-xH2Nb3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:13:32 INFO - Running setup.py (path:/tmp/pip-OzVT3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:13:32 INFO - Running setup.py (path:/tmp/pip-TdS5MC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:13:32 INFO - Running setup.py (path:/tmp/pip-3k77AZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:13:32 INFO - Running setup.py (path:/tmp/pip-k1CSzV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:13:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:13:32 INFO - Running setup.py install for manifestparser 12:13:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:13:32 INFO - Running setup.py install for mozcrash 12:13:32 INFO - Running setup.py install for mozdebug 12:13:32 INFO - Running setup.py install for mozdevice 12:13:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:13:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:13:33 INFO - Running setup.py install for mozfile 12:13:33 INFO - Running setup.py install for mozhttpd 12:13:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:13:33 INFO - Running setup.py install for mozinfo 12:13:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:13:33 INFO - Running setup.py install for mozInstall 12:13:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:13:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:13:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:13:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:13:33 INFO - Running setup.py install for mozleak 12:13:33 INFO - Running setup.py install for mozlog 12:13:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:13:33 INFO - Running setup.py install for moznetwork 12:13:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:13:33 INFO - Running setup.py install for mozprocess 12:13:33 INFO - Running setup.py install for mozprofile 12:13:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:13:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:13:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:13:34 INFO - Running setup.py install for mozrunner 12:13:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:13:34 INFO - Running setup.py install for mozscreenshot 12:13:34 INFO - Running setup.py install for moztest 12:13:34 INFO - Running setup.py install for mozversion 12:13:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:13:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:13:34 INFO - Cleaning up... 12:13:34 INFO - Return code: 0 12:13:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:13:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:13:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:13:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:13:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:13:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13:34 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 0x2966030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c27180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c253b0>, '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 0x2c262b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c26740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1467400282.177338-1438599735', '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 12:13:34 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 12:13:34 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 12:13:34 INFO - Using env: {'DISPLAY': ':0', 12:13:34 INFO - 'HOME': '/home/cltbld', 12:13:34 INFO - 'LANG': 'en_US.UTF-8', 12:13:34 INFO - 'LANGUAGE': 'en_US:en', 12:13:34 INFO - 'LOGNAME': 'cltbld', 12:13:34 INFO - 'MAIL': '/var/mail/cltbld', 12:13:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:13:34 INFO - 'MOZ_NO_REMOTE': '1', 12:13:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:13:34 INFO - 'NO_EM_RESTART': '1', 12:13:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:13:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:13:34 INFO - 'PWD': '/builds/slave/test', 12:13:34 INFO - 'SHELL': '/bin/bash', 12:13:34 INFO - 'SHLVL': '1', 12:13:34 INFO - 'TERM': 'linux', 12:13:34 INFO - 'TMOUT': '86400', 12:13:34 INFO - 'USER': 'cltbld', 12:13:34 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467400282.177338-1438599735', 12:13:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:13:34 INFO - '_': '/tools/buildbot/bin/python'} 12:13:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:13:34 INFO - Running setup.py (path:/tmp/pip-y3s038-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:13:34 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)) 12:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:13:34 INFO - Running setup.py (path:/tmp/pip-6jp0hY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:13:34 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)) 12:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:13:34 INFO - Running setup.py (path:/tmp/pip-EjfZWM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:13:34 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)) 12:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:13:34 INFO - Running setup.py (path:/tmp/pip-jpRM_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:13:34 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)) 12:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:13:34 INFO - Running setup.py (path:/tmp/pip-aqbrAX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:13:35 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)) 12:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:13:35 INFO - Running setup.py (path:/tmp/pip-WCm7rq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:13:35 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)) 12:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:13:35 INFO - Running setup.py (path:/tmp/pip-zc5UaB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:13:35 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)) 12:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:13:35 INFO - Running setup.py (path:/tmp/pip-u9qtbJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:13:35 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)) 12:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:13:35 INFO - Running setup.py (path:/tmp/pip-medzCs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:13:35 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)) 12:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:13:35 INFO - Running setup.py (path:/tmp/pip-cts3RX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:13:35 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)) 12:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:13:35 INFO - Running setup.py (path:/tmp/pip-OgRgNZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:13:35 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)) 12:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:13:35 INFO - Running setup.py (path:/tmp/pip-ici69M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:13:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 12:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:13:35 INFO - Running setup.py (path:/tmp/pip-spUhYM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:13:35 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)) 12:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:13:35 INFO - Running setup.py (path:/tmp/pip-aKMnA3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:13:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 12:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:13:35 INFO - Running setup.py (path:/tmp/pip-z9Ihxr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:13:35 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)) 12:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:13:35 INFO - Running setup.py (path:/tmp/pip-Sx4W2V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:13:35 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)) 12:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:13:35 INFO - Running setup.py (path:/tmp/pip-jIt0Uf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:13:35 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)) 12:13:35 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)) 12:13:35 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)) 12:13:35 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)) 12:13:35 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)) 12:13:35 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)) 12:13:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:13: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 12:13: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 12:13: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 12:13: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 12:13: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 12:13: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 12:13:37 INFO - Downloading blessings-1.6.tar.gz 12:13:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:13:37 INFO - Installing collected packages: blessings 12:13:37 INFO - Running setup.py install for blessings 12:13:37 INFO - Successfully installed blessings 12:13:37 INFO - Cleaning up... 12:13:38 INFO - Return code: 0 12:13:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:13:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:13:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:13:38 INFO - Reading from file tmpfile_stdout 12:13:38 INFO - Current package versions: 12:13:38 INFO - argparse == 1.2.1 12:13:38 INFO - blessings == 1.6 12:13:38 INFO - blobuploader == 1.2.4 12:13:38 INFO - docopt == 0.6.1 12:13:38 INFO - functools32 == 3.2.3-2 12:13:38 INFO - jsonschema == 2.5.1 12:13:38 INFO - manifestparser == 1.1 12:13:38 INFO - mozInstall == 1.12 12:13:38 INFO - mozcrash == 0.17 12:13:38 INFO - mozdebug == 0.1 12:13:38 INFO - mozdevice == 0.48 12:13:38 INFO - mozfile == 1.2 12:13:38 INFO - mozhttpd == 0.7 12:13:38 INFO - mozinfo == 0.9 12:13:38 INFO - mozleak == 0.1 12:13:38 INFO - mozlog == 3.2 12:13:38 INFO - moznetwork == 0.27 12:13:38 INFO - mozprocess == 0.22 12:13:38 INFO - mozprofile == 0.28 12:13:38 INFO - mozrunner == 6.11 12:13:38 INFO - mozscreenshot == 0.1 12:13:38 INFO - mozsystemmonitor == 0.3 12:13:38 INFO - moztest == 0.7 12:13:38 INFO - mozversion == 1.4 12:13:38 INFO - psutil == 3.1.1 12:13:38 INFO - requests == 1.2.3 12:13:38 INFO - wsgiref == 0.1.2 12:13:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:13:38 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')]} 12:13:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:13:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13:38 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')]} 12:13:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:13:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13:38 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 0x2966030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c27180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c253b0>, '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 0x2c262b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c26740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1467400282.177338-1438599735', '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 12:13:38 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 12:13:38 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 12:13:38 INFO - Using env: {'DISPLAY': ':0', 12:13:38 INFO - 'HOME': '/home/cltbld', 12:13:38 INFO - 'LANG': 'en_US.UTF-8', 12:13:38 INFO - 'LANGUAGE': 'en_US:en', 12:13:38 INFO - 'LOGNAME': 'cltbld', 12:13:38 INFO - 'MAIL': '/var/mail/cltbld', 12:13:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:13:38 INFO - 'MOZ_NO_REMOTE': '1', 12:13:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:13:38 INFO - 'NO_EM_RESTART': '1', 12:13:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:13:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:13:38 INFO - 'PWD': '/builds/slave/test', 12:13:38 INFO - 'SHELL': '/bin/bash', 12:13:38 INFO - 'SHLVL': '1', 12:13:38 INFO - 'TERM': 'linux', 12:13:38 INFO - 'TMOUT': '86400', 12:13:38 INFO - 'USER': 'cltbld', 12:13:38 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467400282.177338-1438599735', 12:13:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:13:38 INFO - '_': '/tools/buildbot/bin/python'} 12:13:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:13:38 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)) 12:13:38 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)) 12:13:38 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)) 12:13:38 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)) 12:13:38 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)) 12:13:38 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)) 12:13:38 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)) 12:13:38 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)) 12:13:38 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)) 12:13:38 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)) 12:13:38 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)) 12:13:38 INFO - Cleaning up... 12:13:38 INFO - Return code: 0 12:13:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:13:38 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')]} 12:13:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:13:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13:38 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')]} 12:13:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:13:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13:38 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 0x2966030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c27180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c253b0>, '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 0x2c262b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c26740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1467400282.177338-1438599735', '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 12:13:38 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 12:13:38 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 12:13:38 INFO - Using env: {'DISPLAY': ':0', 12:13:38 INFO - 'HOME': '/home/cltbld', 12:13:38 INFO - 'LANG': 'en_US.UTF-8', 12:13:38 INFO - 'LANGUAGE': 'en_US:en', 12:13:38 INFO - 'LOGNAME': 'cltbld', 12:13:38 INFO - 'MAIL': '/var/mail/cltbld', 12:13:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:13:38 INFO - 'MOZ_NO_REMOTE': '1', 12:13:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:13:38 INFO - 'NO_EM_RESTART': '1', 12:13:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:13:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:13:38 INFO - 'PWD': '/builds/slave/test', 12:13:38 INFO - 'SHELL': '/bin/bash', 12:13:38 INFO - 'SHLVL': '1', 12:13:38 INFO - 'TERM': 'linux', 12:13:38 INFO - 'TMOUT': '86400', 12:13:38 INFO - 'USER': 'cltbld', 12:13:38 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467400282.177338-1438599735', 12:13:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:13:38 INFO - '_': '/tools/buildbot/bin/python'} 12:13:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:13:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:13:38 INFO - Cleaning up... 12:13:38 INFO - Return code: 0 12:13:38 INFO - Running post-action listener: _resource_record_post_action 12:13:38 INFO - Running post-action listener: _start_resource_monitoring 12:13:38 INFO - Starting resource monitoring. 12:13:38 INFO - ##### 12:13:38 INFO - ##### Finished create-virtualenv step (success) 12:13:38 INFO - ##### 12:13:38 INFO - ##### 12:13:38 INFO - ##### Running install step. 12:13:38 INFO - ##### 12:13:38 INFO - Running pre-action listener: _resource_record_pre_action 12:13:38 INFO - Running main action method: install 12:13:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:13:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:13:38 INFO - Reading from file tmpfile_stdout 12:13:38 INFO - Detecting whether we're running mozinstall >=1.0... 12:13:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:13:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:13:39 INFO - Reading from file tmpfile_stdout 12:13:39 INFO - Output received: 12:13:39 INFO - Usage: mozinstall [options] installer 12:13:39 INFO - Options: 12:13:39 INFO - -h, --help show this help message and exit 12:13:39 INFO - -d DEST, --destination=DEST 12:13:39 INFO - Directory to install application into. [default: 12:13:39 INFO - "/builds/slave/test"] 12:13:39 INFO - --app=APP Application being installed. [default: firefox] 12:13:39 INFO - mkdir: /builds/slave/test/build/application 12:13:39 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'] 12:13:39 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 12:13:55 INFO - Reading from file tmpfile_stdout 12:13:55 INFO - Output received: 12:13:55 INFO - /builds/slave/test/build/application/firefox/firefox 12:13:55 INFO - Running post-action listener: _resource_record_post_action 12:13:55 INFO - ##### 12:13:55 INFO - ##### Finished install step (success) 12:13:55 INFO - ##### 12:13:55 INFO - ##### 12:13:55 INFO - ##### Running run-tests step. 12:13:55 INFO - ##### 12:13:55 INFO - Running pre-action listener: _resource_record_pre_action 12:13:55 INFO - Running main action method: run_tests 12:13:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:13:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:13:55 INFO - Python 2.7.3 12:13:55 INFO - Return code: 0 12:13:55 INFO - grabbing minidump binary from tooltool 12:13:55 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')]} 12:13:55 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 0x2c253b0>, '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 0x2c262b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c26740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:13:55 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 12:13:55 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 12:13:55 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 12:13:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:13:55 INFO - Return code: 0 12:13:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:13:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:13:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:13:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:13:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:13:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BDYG5pMWQrOZYLexkHRKKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 12:13:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BDYG5pMWQrOZYLexkHRKKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 12:13:55 INFO - Using env: {'DISPLAY': ':0', 12:13:55 INFO - 'HOME': '/home/cltbld', 12:13:55 INFO - 'LANG': 'en_US.UTF-8', 12:13:55 INFO - 'LANGUAGE': 'en_US:en', 12:13:55 INFO - 'LOGNAME': 'cltbld', 12:13:55 INFO - 'MAIL': '/var/mail/cltbld', 12:13:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:13:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:13:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:13:55 INFO - 'MOZ_NO_REMOTE': '1', 12:13:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:13:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:13:55 INFO - 'NO_EM_RESTART': '1', 12:13:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:13:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:13:55 INFO - 'PWD': '/builds/slave/test', 12:13:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:13:55 INFO - 'SHELL': '/bin/bash', 12:13:55 INFO - 'SHLVL': '1', 12:13:55 INFO - 'TERM': 'linux', 12:13:55 INFO - 'TMOUT': '86400', 12:13:55 INFO - 'USER': 'cltbld', 12:13:55 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467400282.177338-1438599735', 12:13:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:13:55 INFO - '_': '/tools/buildbot/bin/python'} 12:13:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BDYG5pMWQrOZYLexkHRKKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 12:13:55 INFO - mozversion application_buildid: 20160701114222 12:13:55 INFO - mozversion application_changeset: 3bde90c197be1b2f60db5c3d5127d69950ba3b2f 12:13:55 INFO - mozversion application_display_name: Nightly 12:13:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:13:55 INFO - mozversion application_name: Firefox 12:13:55 INFO - mozversion application_remotingname: firefox 12:13:55 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:13:55 INFO - mozversion application_vendor: Mozilla 12:13:55 INFO - mozversion application_version: 50.0a1 12:13:55 INFO - mozversion platform_buildid: 20160701114222 12:13:55 INFO - mozversion platform_changeset: 3bde90c197be1b2f60db5c3d5127d69950ba3b2f 12:13:55 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:13:55 INFO - mozversion platform_version: 50.0a1 12:13:55 INFO - using testdate: 1467400435 12:13:55 INFO - actual date: 1467400435 12:13:55 INFO - starting webserver on 'localhost:52643' 12:13:55 INFO - SUITE-START | Running 2 tests 12:13:55 INFO - TEST-START | dromaeo_css 12:13:55 INFO - operating with platform_type : linux_ 12:13:55 INFO - Initialising browser for dromaeo_css test... 12:13:55 INFO - TEST-INFO | started process 17883 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZA8sex/profile http://localhost:52643/getInfo.html) 12:14:00 INFO - PROCESS | 17883 | __metrics Screen width/height:1600/1200 12:14:00 INFO - PROCESS | 17883 | colorDepth:24 12:14:00 INFO - PROCESS | 17883 | Browser inner width/height: 1024/697 12:14:00 INFO - PROCESS | 17883 | __metrics 12:14:01 INFO - PROCESS | 17883 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:14:02 INFO - TEST-INFO | 17883: exit 0 12:14:02 INFO - Browser initialized. 12:14:02 INFO - Running cycle 1/1 for dromaeo_css test... 12:14:02 INFO - TEST-INFO | started process 17965 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZA8sex/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:14:14 INFO - PROCESS | 17965 | RSS: Main: 158957568 12:14:14 INFO - PROCESS | 17965 | 12:15:04 INFO - PROCESS | 17965 | 1467400504877 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] 12:17:17 INFO - PROCESS | 17965 | Cycle 1(1): loaded http://localhost:52643/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52643/tests/dromaeo/cssquery-ext.html) 12:17:18 INFO - PROCESS | 17965 | RSS: Main: 276373504 12:17:18 INFO - PROCESS | 17965 | 12:20:21 INFO - PROCESS | 17965 | Cycle 1(1): loaded http://localhost:52643/tests/dromaeo/cssquery-ext.html (next: http://localhost:52643/tests/dromaeo/cssquery-jquery.html) 12:20:22 INFO - PROCESS | 17965 | RSS: Main: 242483200 12:20:22 INFO - PROCESS | 17965 | 12:23:24 INFO - PROCESS | 17965 | Cycle 1(1): loaded http://localhost:52643/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52643/tests/dromaeo/cssquery-mootools.html) 12:23:25 INFO - PROCESS | 17965 | RSS: Main: 236421120 12:23:25 INFO - PROCESS | 17965 | 12:26:27 INFO - PROCESS | 17965 | Cycle 1(1): loaded http://localhost:52643/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52643/tests/dromaeo/cssquery-prototype.html) 12:26:28 INFO - PROCESS | 17965 | RSS: Main: 238489600 12:26:28 INFO - PROCESS | 17965 | 12:29:31 INFO - PROCESS | 17965 | Cycle 1(1): loaded http://localhost:52643/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52643/tests/dromaeo/cssquery-yui.html) 12:29:31 INFO - PROCESS | 17965 | RSS: Main: 227655680 12:29:31 INFO - PROCESS | 17965 | 12:32:34 INFO - PROCESS | 17965 | Cycle 1(1): loaded http://localhost:52643/tests/dromaeo/cssquery-yui.html (next: http://localhost:52643/tests/dromaeo/cssquery-dojo.html) 12:32:34 INFO - PROCESS | 17965 | RSS: Main: 309067776 12:32:34 INFO - PROCESS | 17965 | 12:32:34 INFO - PROCESS | 17965 | __start_tp_report 12:32:34 INFO - PROCESS | 17965 | _x_x_mozilla_page_load 12:32:34 INFO - PROCESS | 17965 | _x_x_mozilla_page_load_details 12:32:34 INFO - PROCESS | 17965 | |i|pagename|runs| 12:32:34 INFO - PROCESS | 17965 | |0;dojo.html;2602.1803132013415;2623.501534708404;2646.788256939445;2665.6268122462857;2668.1061844282162;4567.292069729189;4620.2838560023165;4735.952640473599;4779.90440191196;4802.951970480294;4675.602573781224;4687.789049492772;4702.3651807006045;4727.4563425206115;4731.503192164825;4085.428040074392;4239.724417912841;4340.67444941629;4359.585839345257;4439.977800110995;4362.541933097027;4403.713758605696;4411.073674528337;4425;4456.153330867141;4242.278812601834;4288.571142885718;4310.547392523803;4356.194104090753;4364.018095928391;4262.65898728101;4270.145970805851;4277.337012763027;4314.094040251551;4346.043870348518;4300.806463709109;4317.4819021717285;4324;4357.891052723676;4359;4557.9772101139615;4640.211164102111;4670.743109128996;4699.483056863776;4706.5293470653005;5102.336696229503;5122.129238029544;5126.256692779563;5128.358955130609;5140.203268493389;5090.38915330159;5142.742862856842;5156.226566015128;5170.741462926839;5171.922421163686;4605.424321959755;4667.043256132485;4683.976580117146;4734.644901632322;4738.3129446230105;5191.792328306826;5246.213068039749;5250.369955605275;5255.474452554714;5256.211568264791;4822.107910036654;4983.377077865267;4986;4993.1262029144755;5040.697558146449;4977.875553111201;5020.397552293675;5020.548150666385;5045.217991211368;5109.029284435946;4997.600191984705;5001.44984051754;5002.674826136289;5008.223725322581;5057.822976195889;4863.440704318978;4972.776225069881;5008.273800298936;5012.649114561946;5062.341895553554;4212.220739163265;4232.280512312914;4274.615284624399;4293.957060429419;4335.544767799399;3741.102135487518;3750.6999440044733;3755.080005398695;3786.2995345861104;3799.430085487199;4362.236608593484;4362.454693163355;4371.169477799208;4413.713108647928;4413.955860441419;4939.2838038484215;4981.850544483671;4987.526185012418;5014.473480284518;5045.445001049881;4347.174036932973;4355.499117601516;4355.869323920288;4370.672199585044;4407.581279778416;4539.024109816405;4541.863744087683;4543.931841022388;4547.226971414867;4598.540145985375;4629.305604159335;4684.882877928079;4725.692829966041;4738.265568836836;4777.665563410528;5064.721440320818;5085.0338435697095;5092.567131793691;5100.897982040413;5138.409082955359;4607.6313894889;4729.196036673705;4759.690620109682;4759.904801903874;4799.0401919615515;4910.337104490848;4922.064807686528;4940.654154209171;4969.031038947371;4974.5771609413605;5021.623378246573;5042.168042272984;5043.2687260347775;5047.343845300087;5090.821821236239;4805.495422980537;4851.29656199842;4877.512248775236;4883.194272944925;4918.754062296943;4907.484714104968;4942.159832828356;4973.875653108701;4974.900501990012;5016.6237532184505;4885.828995985124;4892.877678057935;4897.975510122569;4942.901141977212;4955;4806.399200099988;4879.780409881493;4932.605391568594;4992.825251116194;5036.874078148076;4716.844373128605;4725.574698277172;4762.14281429346;4763.071201115749;4775.6657034007285 12:32:34 INFO - PROCESS | 17965 | |1;ext.html;540.33722914335;585.4204337705671;590.6898878089005;590.881823635273;592.8428966323924;39986.80006599967;40315.395269070985;40993;41173;41454.37818432722;37256;41333.7933310333;41479.79260103703;41533;41572;7538.9246107538775;7875;8013.879791803128;8027.076886158079;10294.227932905025;9991.90008099917;10430;10466.215033872451;10468.94765526175;10471.947640261787;10422.478876056166;10505.369677819355;10517.211209159306;10575.682729518088;10579.84130238047;10364.429956352398;10418.687439376756;10474.376471646907;10479.58081676732;10480.895191048068;10346.896531034668;10409.79180416395;10414.323069000491;10418.218633602435;10418.531166097468;39817.80091099555;40188.79905600454;40231.19537609231;40380.192396152204;40381.59618403837;3096.194989302775;3103.3948380065895;3141.356022015504;3205.487122060459;3365.1418888183603;30537.389252215053;30690.38619227625;31021.84489077563;31317.37365252682;31360.21599460009;3318.1538707629643;3334.2664613785173;3353.865845366207;3354.37943980362;3374.6962773350515;257742;261855;262181;263480.9999999981;264047;57374.139387909214;57735.71132144312;57823.710881445324;57844;57999;62214.37785622176;62254.0661890072;62290.68854655788;62311.688441557504;62338.68830655818;15181.316840742193;15474.690506190038;15478.226088695521;15486.380544778309;15487.457938972308;10467.790644187226;11261.099112071015;11330.830037549444;11355.60255391074;11809.40952952349;19119;19172.233110675417;19189;19191.232350705814;19250.422487325122;5681.886362272731;6933.757318493828;7184.892226616605;7195.496315257987;7270.527415717961;820.4052062254817;912.7991841794794;933.2021121940643;975.2490582251627;1018.3410352803652;28062.719372806012;28155;28564.857175714405;29064.418711626073;29192.854035729684;969.1568335548118;992.1021475564626;1018.974525636865;1049.559185142242;1075.870895492546;14900.403983840743;15067.623309417353;15368.923155384151;15660;15701.214939252992;376023;376631;379683;380551;381668;49432.50567494351;49695.50304496981;49986;50032.49967500351;50062.749686251336;1082.355998181081;1121.8092924202742;1181.4092953523239;1195.9521619135137;1211.8848709372596;27098.593521096805;29161.56257656179;29419.585732565374;29519;29963.250918727208;41568.376474352306;41930.37104443497;41948;41985.16029679451;42015;243511;248065;249656;250919;251075;32838.67161328452;36526.08684782795;37839.810800945816;39150.412743808294;42059.579404206794;41984.79007604942;42477.78761106174;42645.57354426416;42870.57129428666;43610;36213.63786362103;36490.8175459121;36598.8170059148;36768;37009.07477313089;34745.30509389748;37739.245215096096;37965.620343797316;38111.42832857565;38125.237495249385;36759.63240367562;37476.06309842167;37707;37728.81135594304;37881;32453.51319730253;33668.83165584156;33843.323133537684;34380;34529.654703452645;25304.240872773848;25722.485550288515;25842.68542071969;26115.369740482452;26240.73759262383 12:32:34 INFO - PROCESS | 17965 | |2;jquery.html;345.48522701175256;359.7373917040562;368.2744992365041;370.82200543739003;382.33473755665136;12980.286084265374;16575.088370139638;16893.07088110155;17561.91219043903;18470.261189552402;16931.407400740976;16999.405020824273;17122.40071597494;17551.82448175521;17668.204930778113;5100.081985242655;5256.474352564732;5539.058360078776;5544.695041772701;5595.104783234683;3488.1802776347663;5420.430854760252;5512.366077901052;5667.149927510885;5681.687507187103;5707.229524014247;5723.4848863602265;5746.281714785652;5750.7412166452405;5752.942470575283;5369.812056578021;5461.344638643388;5469.507744302992;5469.890602187974;5469.972650136724;3399.354122716676;5163.870903227412;5269.314989051437;5459.454054594548;5465.180222966547;12445.688857778538;12548.874511254862;12652.304123273216;14568.781468277984;20855;1927.9036048197675;1943.5335519475366;1950.7268982342484;2077;2422.6123820188686;8950.59722312491;9449.43303401798;9454.669086581936;12229.449674764657;12637.988960883107;1760.0935518208132;1772.3176577017812;1778.6798376292263;1810.2849374497;1844.4190080124852;60300.69849650723;67172;68261.65869170672;68667.31332686658;69034.30965690379;8943.3739638226;9437.57530911097;10050;10133.493325333704;10179.338343007681;12734.554290599785;13578.524751633842;13582;13913.513027044004;14007.929960350337;6787.966060169668;7102.751403700846;7162.570245785269;7365.2634736525915;7462.925370746331;7033.226345102034;7065.328793764585;7142.357187853118;7214.350708436266;7262.455315851333;4355.206410926981;4361.80371883266;4395.802188901507;4445.844395446144;4473.4408198975125;1777.9644407111784;1808.264066496152;1824.6077093424976;1836.2287839107607;1883.2843519462517;778.7040924448673;871.5163084488044;888.626776753765;896.7399454158221;898.7842917699836;16750.413735519443;17188;17572.648547028988;17751.55575879273;17889.910550447163;839.2111415269749;852.1691350932915;870.8127752533236;878.6968495868915;913.5614904845578;9450;10244.795104097877;10266.435346055889;10562.313449625903;10629.627963021412;319539;322998;326440;422757;425370;81542.28361323637;88921;89205.55397223102;89259;89810;919.5034681272172;940.7742141885898;943.2501161576427;944.9480278584743;946.6118891254553;16056.718905137383;16188.190590470194;16325.59186020359;16573.17134143312;16742;31223.531647025768;34233;38629.02261035946;39072.6092739069;39759.2048159041;51687;52439;54774.17838732502;55117.44882551123;56703;7522;7842.372610191057;7936.563489007929;7953.204679532;8020.398470114648;8937.865932011155;10937.671869843918;11346.829797553208;11885.28688278706;12497.37513124322;9826.16477599412;10303.587856485656;10353.585856565653;10364.959132960103;10439.269251152346;10410.531526081497;10552.419616921143;10732.087772539422;10770.838437423288;10788.190885683762;10320.948395257976;10573.101286390436;10758.13934885223;10873;11020.283681560673;7796.220377962159;7832.530048196899;7872.527648341118;7879;7933.8413231736195;8569.657213711382;10441.216908731723;10541.683749487527;10710.892891071302;10711.732206694895 12:32:34 INFO - PROCESS | 17965 | |3;mootools.html;1269.7016201192723;1374.7387996280706;1443.7040406716621;1506.4877941499888;1714.2486956261741;6867.244603093655;7603.543787372754;7863.882041769378;7883.369330453572;8145.104038555754;7911.802204944879;8074.273315401612;8091.3526917846575;8097.190280971915;8103.149169337223;2195.3962660268435;2230.319752475494;2234.106357457014;2234.229190929135;2235.0836157175563;2173.2285038811233;2195.626743453609;2219.833512486562;2222.144474377368;2226.899789509468;2193.0679461228992;2195.9560808783813;2203.1407750977132;2203.283932721864;2239.4625289930464;2156.2884248198134;2162.3945295317335;2163.1131236193087;2164.199246278879;2165.07984106754;2105.1789801977243;2145.0776166248506;2146.4848436375314;2147.95704085919;2149.3014770199748;7929.484583502054;8036.919630803675;8041;8055.879161812519;8186.631601577943;4461.754603496806;4579.977100114478;4588.059447813223;4594.954050459486;4600.240960241556;2843.2039029071893;3039.285767844555;3053.7709671774705;3084.290613158986;3091.134482344947;925.1673493855517;925.8333499970003;939.9671011514564;948.9905100948971;952.1002652493396;10887.237893347468;10967.780644387147;10978.066864316543;10994.34033957957;10995.450227488673;3953.3000809652126;4110.938335924963;4114.958850411517;4140.937885931713;4288.764117973541;8473.703420380258;8562;8569.143085691505;8584.442011269248;8589.184027517376;4440;4441.622462090694;4444.4888837784065;4447.155040542287;4447.933281000787;3677.669009789132;3993.9201215975518;4118.670506359484;4124.360724087771;4150.481189851269;3479.8608055677996;3507.316073365669;3509.3156834417555;3596.7482276240935;3613.060604242916;1015.7968406318765;1033.6278939581744;1038.08129805123;1040.2198351236573;1048.444324508012;674.6963866260203;821.7863355527486;835.6114406800867;838.3837879158814;856.4005196362447;5078.7460626968505;5155.7679904404395;5249.606279529051;5285.497877701612;5321.148616221386;393.36471598369;393.55921368067374;398.5496389080321;427.26510402108323;434.13606922224545;3536.398812201932;3644.7630903991158;3675.2649470106085;3684.447332900033;3684.5394325709285;9688.273379496566;10046.29675922693;10064.69805905824;10162.288639795292;10167.4916254187;10042.69871903844;10062.19502439803;10087.092161705481;10107.949460252652;10110.090091891765;7501.437392195608;7594.354479869163;7668.233176682287;7685.077790665044;7700.114486833973;5085.338905942203;5106.412762532356;5133.07604631155;5153.149730294459;5185.766640501111;9137.63449462014;9179.127982841619;9241.86137207929;9311.86032209531;9362.625494980124;9244.537773111451;9471.47906865129;9490.383125096847;9586.66446674363;9588.76028099303;5957.374475680164;6089;6149.969250153899;6631.701573429111;6704.094947182068;7212.89180662301;7442.479026468095;7456.589887556236;7651.234876512304;7652.196519365609;6508.967455162883;6634.734610615715;6646.102776125162;6714.630695311805;6770.729170833111;6515.250746164252;6555.3772391622715;6570.277269500447;6629;6712.966435167793;5861.6189947653265;5868.589198756217;5905.232319798571;5914.378990205966;5914.674692891932;4243.596858298457;4308.202982448257;4356.586124318184;4395.296752519582;4434.068845542472;4385.868423947287;4427.29163333865;4465.754383508808;4477.059817438374;4517.954820451753 12:32:34 INFO - PROCESS | 17965 | |4;prototype.html;292.8272319331594;301.5446675519965;306.5845778969496;309.313324419788;311.1179805252112;4818.530657926296;4825.638077144211;4844.467108618053;4853.635977301703;4884.975575122119;4779.856604301876;4788.186008378575;4792.562231330596;4798.928016079762;4800.399950006249;3577.481265216542;3711.443283507482;3719.163188282642;3727.589965103836;3742.2141350316465;3641.7814931104085;3746.7939263340504;3811.7331786774935;3822.808859557011;3829.48301979232;3709.5733990591025;3761.153740408414;3774.5279341057008;3775.528058992626;3785.7728536287773;3523.5553423096408;3741.5323084614424;3762.8118594070324;3792.50697409335;3818.102745854722;3277.8033318001;3281.6226133994655;3283.3925723740945;3288.128645908836;3293.4730443129224;4728.1252968201;4728.40894888139;4763.857084287477;4766.142094423002;4768.403949506312;4267.530571637118;4270.402143699885;4292.527821939615;4302.913941721179;4314.525402205755;4914.066327397783;5012.298278241049;5021.096202683516;5037.647364684437;5088.440271570124;3568.8750893718857;3584.22939068099;3598.1364472526666;3604.3960437605274;3609.8736544221088;5209.973950130225;5227.320448341729;5234.842954711365;5243.239730239132;5256.369235691704;3562.8931132066077;3693.9815300923324;3697.815109244581;3705.166337574024;3708.8331025103935;3706.5552133744122;3731.272401881607;3738.345789486829;3743.3636281832155;3751.437284407361;4260.10537787062;4271.337942618837;4271.8466014176;4272.316429371285;4274.610751505773;4919.36048313724;5017.698938063655;5066.113430149783;5066.859956509756;5071.391433027987;1269.6825793551611;1291.2446218961825;1291.7351942851692;1293.2822283632674;1295.7538067767093;813.4671789977574;819.148085990575;819.7827575692446;826.7933016745814;839.6305625524872;4331.913361732748;4496.797644106023;4513.277875539898;4516.570925762047;4516.8193272268745;5185.403678576937;5189.896202075937;5204.739763011834;5224.425313215544;5272.314599102092;4386.2762644163995;4479.55204479556;4481.708688935209;4493.707908985905;4532.388127602731;2718.9803823566162;2752.683441404224;2773.791965602588;2782.1375373634237;2782.5547912333927;4909.1654418748185;4916.115099282092;4922.261660750844;4922.680025798311;4950.777215025332;5185.807264329225;5233.685978841282;5307.575393968474;5309.973450132725;5351.304330437096;4875.414950205998;4897.216445368724;4898.314236006961;4915.877103072452;4916.483769204254;5231.913171228841;5238.930622404206;5255.290535777774;5305.814296499604;5309.681419114865;4778.952210477851;5057.949420505748;5072.4673909239;5088.771005304696;5164.664296820694;4886.315915771724;4888.7311197884455;4914.70511769295;4918.729469879191;4924.335214745964;3696.7042636589545;3727.720420968384;3733.0480727414338;3737.3646480097905;3749.2501499700716;5199.246109314053;5295.4581800735095;5301.469853014668;5309.973450132725;5314.415414304501;5058.3929928408825;5064.46823083571;5094.184930411265;5101.9489805101475;5131.204663277198;4998.2502624606595;5046.924296135634;5052.8989420210655;5054.59563234933;5100.336956195819;4774.21225497789;4975.830679790319;4985.950140498694;4988.501149884983;5000.824971126139;4836.830710925101;4957.3059771632725;4975.5522003019905;4977.228529577921;5118.129917913889;4851.56335929768;4895.216765317532;5000.1749711297225;5023.146065169003;5027.723475208899 12:32:34 INFO - PROCESS | 17965 | |5;yui.html;639.6418005916687;663.6117871045436;690.078744875591;715.2061212054622;740.3336996702967;12847.678808029805;13701.657458563515;13863.514776982807;13869.861301386984;13881.028328017055;12758.298293593849;13483.528076517325;13488.325583720823;13499.122557033787;13515.797263041062;627.5199472403615;743.9814004649886;755.1466842468031;771.5717776633966;790.8062524681461;656.3666062249928;672.7645324136562;673.168636733636;673.2157037051828;673.2190658835751;844.1895780051158;848.6138806842903;848.8684253940618;849.2399302624148;849.7875531117221;637.5791977294987;796.5618909599755;829.5810615639064;841.247083859945;841.7011960753936;606.9635821850659;609.9329073801878;609.9908501372483;610.3713175429315;610.5207412181461;12279.508819647204;12357.011439084852;12369.69075773104;12382.257064576153;12453.688657783538;11375.829362559569;12368.690782730413;12797.808032879515;12828.273258973806;13179;11196.944015279953;11237.775244495064;11570.190086693934;11616.94191529037;12322.445489952885;4163.10493243951;4165.271077561445;4242.7242229255;4371.934420983688;4374.956250437519;59935.70032149855;61459.69270153665;61459.77080458411;61658.075128873104;61768.69115654438;9646.641701856548;9727.221822254203;9759.560819763128;9767.072128147815;10149.492525373702;14538.127712337293;14609.123452592667;14666.486672966608;14667.04664196845;14691.118532887847;6384.3934826191435;6730.730770769114;6764.458843292525;6900.930990690129;6958.434352270699;3650.452432135148;3711.925761484755;3744.8876533704033;3802.885913422602;3938.9212215755524;2714.7013828478853;2800.719928007183;2805.5370863807652;2806.2843974786297;2808.424273024066;509.969401835891;512.1753976098479;522.6002108387087;528.9603279754034;572.2103497173873;595.4611076975344;609.6707777800027;617.3826173826174;625.3090335179652;637.9362063793584;8094.473859199134;8684.60919258635;8820.514871682119;8836.734897953073;8893.155150260714;616.4513582911212;627.4917316973266;630.4735545819201;630.9242591872687;636.0681601453892;4011.4584531088512;4041.636252737209;4074.3888416737727;4184.497860256789;4220.134872351161;58246.12630810541;72685.63657181681;96940.51529742306;105785;107122.46438767757;54667;72662.27337726661;79466;88341.55829220942;88991;79821;80632;84965.15034849572;85073.57463212768;85106.14893851106;7851.568163751049;7955.960220198862;8081.757547273592;8091.595420229083;8247.21651443112;33558.3288334227;38431.61568384281;38937.73551049762;40609.36039157445;41395.58604413917;59419.1087133702;60197.699011504665;61135;61208.69395652993;63022.36977630165;11087.611933582286;11206.607768728381;11276.605318813803;11359.659210223706;11596.826047609462;12338.259704417764;12386.62840114798;12494.500219991098;12689.492420303084;12958.874826439227;11867.940660296988;11916.582919597773;12363.134580579273;12393.504259829506;12771.872281277068;11530.711732206762;11642.41787910618;11770.646880593597;11825.940870295593;12541.247525148521;11251.38117403518;11361.320358862642;11990.160688751703;12149.331786751813;12847.871521284667;9938.10557049869;9946.900530994597;10087.596496140071;10110.292279540361;10524.52639631203;9782.951085244527;10248.53881575316;10290;10319.122874555747;10345.586176552853 12:32:34 INFO - PROCESS | 17965 | __end_tp_report 12:32:34 INFO - PROCESS | 17965 | __start_cc_report 12:32:34 INFO - PROCESS | 17965 | _x_x_mozilla_cycle_collect,1087 12:32:34 INFO - PROCESS | 17965 | __end_cc_report 12:32:34 INFO - PROCESS | 17965 | __startTimestamp1467401554956__endTimestamp 12:32:34 INFO - PROCESS | 17965 | 12:32:34 INFO - PROCESS | 17965 | ------- Summary: start ------- 12:32:34 INFO - PROCESS | 17965 | Number of tests: 6 12:32:34 INFO - PROCESS | 17965 | 12:32:34 INFO - PROCESS | 17965 | [#0] dojo.html Cycles:165 Average:4661.50 Median:4759.90 stddev:491.00 (10.3%) stddev-sans-first:465.17 12:32:34 INFO - PROCESS | 17965 | Values: 2602.2 2623.5 2646.8 2665.6 2668.1 4567.3 4620.3 4736.0 4779.9 4803.0 4675.6 4687.8 4702.4 4727.5 4731.5 4085.4 4239.7 4340.7 4359.6 4440.0 4362.5 4403.7 4411.1 4425.0 4456.2 4242.3 4288.6 4310.5 4356.2 4364.0 4262.7 4270.1 4277.3 4314.1 4346.0 4300.8 4317.5 4324.0 4357.9 4359.0 4558.0 4640.2 4670.7 4699.5 4706.5 5102.3 5122.1 5126.3 5128.4 5140.2 5090.4 5142.7 5156.2 5170.7 5171.9 4605.4 4667.0 4684.0 4734.6 4738.3 5191.8 5246.2 5250.4 5255.5 5256.2 4822.1 4983.4 4986.0 4993.1 5040.7 4977.9 5020.4 5020.5 5045.2 5109.0 4997.6 5001.4 5002.7 5008.2 5057.8 4863.4 4972.8 5008.3 5012.6 5062.3 4212.2 4232.3 4274.6 4294.0 4335.5 3741.1 3750.7 3755.1 3786.3 3799.4 4362.2 4362.5 4371.2 4413.7 4414.0 4939.3 4981.9 4987.5 5014.5 5045.4 4347.2 4355.5 4355.9 4370.7 4407.6 4539.0 4541.9 4543.9 4547.2 4598.5 4629.3 4684.9 4725.7 4738.3 4777.7 5064.7 5085.0 5092.6 5100.9 5138.4 4607.6 4729.2 4759.7 4759.9 4799.0 4910.3 4922.1 4940.7 4969.0 4974.6 5021.6 5042.2 5043.3 5047.3 5090.8 4805.5 4851.3 4877.5 4883.2 4918.8 4907.5 4942.2 4973.9 4974.9 5016.6 4885.8 4892.9 4898.0 4942.9 4955.0 4806.4 4879.8 4932.6 4992.8 5036.9 4716.8 4725.6 4762.1 4763.1 4775.7 12:32:34 INFO - PROCESS | 17965 | 12:32:34 INFO - PROCESS | 17965 | [#1] ext.html Cycles:180 Average:46979.50 Median:18521.76 stddev:79153.41 (427.4%) stddev-sans-first:79298.66 12:32:34 INFO - PROCESS | 17965 | Values: 540.3 585.4 590.7 590.9 592.8 39986.8 40315.4 40993.0 41173.0 41454.4 37256.0 41333.8 41479.8 41533.0 41572.0 7538.9 7875.0 8013.9 8027.1 10294.2 9991.9 10430.0 10466.2 10468.9 10471.9 10422.5 10505.4 10517.2 10575.7 10579.8 10364.4 10418.7 10474.4 10479.6 10480.9 10346.9 10409.8 10414.3 10418.2 10418.5 39817.8 40188.8 40231.2 40380.2 40381.6 3096.2 3103.4 3141.4 3205.5 3365.1 30537.4 30690.4 31021.8 31317.4 31360.2 3318.2 3334.3 3353.9 3354.4 3374.7 257742.0 261855.0 262181.0 263481.0 264047.0 57374.1 57735.7 57823.7 57844.0 57999.0 62214.4 62254.1 62290.7 62311.7 62338.7 15181.3 15474.7 15478.2 15486.4 15487.5 10467.8 11261.1 11330.8 11355.6 11809.4 19119.0 19172.2 19189.0 19191.2 19250.4 5681.9 6933.8 7184.9 7195.5 7270.5 820.4 912.8 933.2 975.2 1018.3 28062.7 28155.0 28564.9 29064.4 29192.9 969.2 992.1 1019.0 1049.6 1075.9 14900.4 15067.6 15368.9 15660.0 15701.2 376023.0 376631.0 379683.0 380551.0 381668.0 49432.5 49695.5 49986.0 50032.5 50062.7 1082.4 1121.8 1181.4 1196.0 1211.9 27098.6 29161.6 29419.6 29519.0 29963.3 41568.4 41930.4 41948.0 41985.2 42015.0 243511.0 248065.0 249656.0 250919.0 251075.0 32838.7 36526.1 37839.8 39150.4 42059.6 41984.8 42477.8 42645.6 42870.6 43610.0 36213.6 36490.8 36598.8 36768.0 37009.1 34745.3 37739.2 37965.6 38111.4 38125.2 36759.6 37476.1 37707.0 37728.8 37881.0 32453.5 33668.8 33843.3 34380.0 34529.7 25304.2 25722.5 25842.7 26115.4 26240.7 12:32:34 INFO - PROCESS | 17965 | 12:32:34 INFO - PROCESS | 17965 | [#2] jquery.html Cycles:180 Average:23823.41 Median:231258.10 stddev:61039.68 (26.4%) stddev-sans-first:61185.46 12:32:34 INFO - PROCESS | 17965 | Values: 345.5 359.7 368.3 370.8 382.3 12980.3 16575.1 16893.1 17561.9 18470.3 16931.4 16999.4 17122.4 17551.8 17668.2 5100.1 5256.5 5539.1 5544.7 5595.1 3488.2 5420.4 5512.4 5667.1 5681.7 5707.2 5723.5 5746.3 5750.7 5752.9 5369.8 5461.3 5469.5 5469.9 5470.0 3399.4 5163.9 5269.3 5459.5 5465.2 12445.7 12548.9 12652.3 14568.8 20855.0 1927.9 1943.5 1950.7 2077.0 2422.6 8950.6 9449.4 9454.7 12229.4 12638.0 1760.1 1772.3 1778.7 1810.3 1844.4 60300.7 67172.0 68261.7 68667.3 69034.3 8943.4 9437.6 10050.0 10133.5 10179.3 12734.6 13578.5 13582.0 13913.5 14007.9 6788.0 7102.8 7162.6 7365.3 7462.9 7033.2 7065.3 7142.4 7214.4 7262.5 4355.2 4361.8 4395.8 4445.8 4473.4 1778.0 1808.3 1824.6 1836.2 1883.3 778.7 871.5 888.6 896.7 898.8 16750.4 17188.0 17572.6 17751.6 17889.9 839.2 852.2 870.8 878.7 913.6 9450.0 10244.8 10266.4 10562.3 10629.6 319539.0 322998.0 326440.0 422757.0 425370.0 81542.3 88921.0 89205.6 89259.0 89810.0 919.5 940.8 943.3 944.9 946.6 16056.7 16188.2 16325.6 16573.2 16742.0 31223.5 34233.0 38629.0 39072.6 39759.2 51687.0 52439.0 54774.2 55117.4 56703.0 7522.0 7842.4 7936.6 7953.2 8020.4 8937.9 10937.7 11346.8 11885.3 12497.4 9826.2 10303.6 10353.6 10365.0 10439.3 10410.5 10552.4 10732.1 10770.8 10788.2 10320.9 10573.1 10758.1 10873.0 11020.3 7796.2 7832.5 7872.5 7879.0 7933.8 8569.7 10441.2 10541.7 10710.9 10711.7 12:32:34 INFO - PROCESS | 17965 | 12:32:34 INFO - PROCESS | 17965 | [#3] mootools.html Cycles:180 Average:5133.07 Median:4454.84 stddev:2979.16 (66.9%) stddev-sans-first:2973.37 12:32:34 INFO - PROCESS | 17965 | Values: 1269.7 1374.7 1443.7 1506.5 1714.2 6867.2 7603.5 7863.9 7883.4 8145.1 7911.8 8074.3 8091.4 8097.2 8103.1 2195.4 2230.3 2234.1 2234.2 2235.1 2173.2 2195.6 2219.8 2222.1 2226.9 2193.1 2196.0 2203.1 2203.3 2239.5 2156.3 2162.4 2163.1 2164.2 2165.1 2105.2 2145.1 2146.5 2148.0 2149.3 7929.5 8036.9 8041.0 8055.9 8186.6 4461.8 4580.0 4588.1 4595.0 4600.2 2843.2 3039.3 3053.8 3084.3 3091.1 925.2 925.8 940.0 949.0 952.1 10887.2 10967.8 10978.1 10994.3 10995.5 3953.3 4110.9 4115.0 4140.9 4288.8 8473.7 8562.0 8569.1 8584.4 8589.2 4440.0 4441.6 4444.5 4447.2 4447.9 3677.7 3993.9 4118.7 4124.4 4150.5 3479.9 3507.3 3509.3 3596.7 3613.1 1015.8 1033.6 1038.1 1040.2 1048.4 674.7 821.8 835.6 838.4 856.4 5078.7 5155.8 5249.6 5285.5 5321.1 393.4 393.6 398.5 427.3 434.1 3536.4 3644.8 3675.3 3684.4 3684.5 9688.3 10046.3 10064.7 10162.3 10167.5 10042.7 10062.2 10087.1 10107.9 10110.1 7501.4 7594.4 7668.2 7685.1 7700.1 5085.3 5106.4 5133.1 5153.1 5185.8 9137.6 9179.1 9241.9 9311.9 9362.6 9244.5 9471.5 9490.4 9586.7 9588.8 5957.4 6089.0 6150.0 6631.7 6704.1 7212.9 7442.5 7456.6 7651.2 7652.2 6509.0 6634.7 6646.1 6714.6 6770.7 6515.3 6555.4 6570.3 6629.0 6713.0 5861.6 5868.6 5905.2 5914.4 5914.7 4243.6 4308.2 4356.6 4395.3 4434.1 4385.9 4427.3 4465.8 4477.1 4518.0 12:32:34 INFO - PROCESS | 17965 | 12:32:34 INFO - PROCESS | 17965 | [#4] prototype.html Cycles:180 Average:4198.64 Median:4799.66 stddev:1223.63 (25.5%) stddev-sans-first:1191.43 12:32:34 INFO - PROCESS | 17965 | Values: 292.8 301.5 306.6 309.3 311.1 4818.5 4825.6 4844.5 4853.6 4885.0 4779.9 4788.2 4792.6 4798.9 4800.4 3577.5 3711.4 3719.2 3727.6 3742.2 3641.8 3746.8 3811.7 3822.8 3829.5 3709.6 3761.2 3774.5 3775.5 3785.8 3523.6 3741.5 3762.8 3792.5 3818.1 3277.8 3281.6 3283.4 3288.1 3293.5 4728.1 4728.4 4763.9 4766.1 4768.4 4267.5 4270.4 4292.5 4302.9 4314.5 4914.1 5012.3 5021.1 5037.6 5088.4 3568.9 3584.2 3598.1 3604.4 3609.9 5210.0 5227.3 5234.8 5243.2 5256.4 3562.9 3694.0 3697.8 3705.2 3708.8 3706.6 3731.3 3738.3 3743.4 3751.4 4260.1 4271.3 4271.8 4272.3 4274.6 4919.4 5017.7 5066.1 5066.9 5071.4 1269.7 1291.2 1291.7 1293.3 1295.8 813.5 819.1 819.8 826.8 839.6 4331.9 4496.8 4513.3 4516.6 4516.8 5185.4 5189.9 5204.7 5224.4 5272.3 4386.3 4479.6 4481.7 4493.7 4532.4 2719.0 2752.7 2773.8 2782.1 2782.6 4909.2 4916.1 4922.3 4922.7 4950.8 5185.8 5233.7 5307.6 5310.0 5351.3 4875.4 4897.2 4898.3 4915.9 4916.5 5231.9 5238.9 5255.3 5305.8 5309.7 4779.0 5057.9 5072.5 5088.8 5164.7 4886.3 4888.7 4914.7 4918.7 4924.3 3696.7 3727.7 3733.0 3737.4 3749.3 5199.2 5295.5 5301.5 5310.0 5314.4 5058.4 5064.5 5094.2 5101.9 5131.2 4998.3 5046.9 5052.9 5054.6 5100.3 4774.2 4975.8 4986.0 4988.5 5000.8 4836.8 4957.3 4975.6 4977.2 5118.1 4851.6 4895.2 5000.2 5023.1 5027.7 12:32:34 INFO - PROCESS | 17965 | 12:32:34 INFO - PROCESS | 17965 | [#5] yui.html Cycles:180 Average:17266.16 Median:511.07 stddev:24594.29 (4812.3%) stddev-sans-first:24631.60 12:32:34 INFO - PROCESS | 17965 | Values: 639.6 663.6 690.1 715.2 740.3 12847.7 13701.7 13863.5 13869.9 13881.0 12758.3 13483.5 13488.3 13499.1 13515.8 627.5 744.0 755.1 771.6 790.8 656.4 672.8 673.2 673.2 673.2 844.2 848.6 848.9 849.2 849.8 637.6 796.6 829.6 841.2 841.7 607.0 609.9 610.0 610.4 610.5 12279.5 12357.0 12369.7 12382.3 12453.7 11375.8 12368.7 12797.8 12828.3 13179.0 11196.9 11237.8 11570.2 11616.9 12322.4 4163.1 4165.3 4242.7 4371.9 4375.0 59935.7 61459.7 61459.8 61658.1 61768.7 9646.6 9727.2 9759.6 9767.1 10149.5 14538.1 14609.1 14666.5 14667.0 14691.1 6384.4 6730.7 6764.5 6900.9 6958.4 3650.5 3711.9 3744.9 3802.9 3938.9 2714.7 2800.7 2805.5 2806.3 2808.4 510.0 512.2 522.6 529.0 572.2 595.5 609.7 617.4 625.3 637.9 8094.5 8684.6 8820.5 8836.7 8893.2 616.5 627.5 630.5 630.9 636.1 4011.5 4041.6 4074.4 4184.5 4220.1 58246.1 72685.6 96940.5 105785.0 107122.5 54667.0 72662.3 79466.0 88341.6 88991.0 79821.0 80632.0 84965.2 85073.6 85106.1 7851.6 7956.0 8081.8 8091.6 8247.2 33558.3 38431.6 38937.7 40609.4 41395.6 59419.1 60197.7 61135.0 61208.7 63022.4 11087.6 11206.6 11276.6 11359.7 11596.8 12338.3 12386.6 12494.5 12689.5 12958.9 11867.9 11916.6 12363.1 12393.5 12771.9 11530.7 11642.4 11770.6 11825.9 12541.2 11251.4 11361.3 11990.2 12149.3 12847.9 9938.1 9946.9 10087.6 10110.3 10524.5 9783.0 10248.5 10290.0 10319.1 10345.6 12:32:34 INFO - PROCESS | 17965 | -------- Summary: end -------- 12:32:34 INFO - PROCESS | 17965 | 12:32:35 INFO - TEST-INFO | 17965: exit 0 12:32:35 INFO - TEST-OK | dromaeo_css | took 1120147ms 12:32:35 INFO - TEST-START | kraken 12:32:35 INFO - operating with platform_type : linux_ 12:32:35 INFO - Initialising browser for kraken test... 12:32:35 INFO - TEST-INFO | started process 18155 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptZSgPj/profile http://localhost:52643/getInfo.html) 12:32:40 INFO - PROCESS | 18155 | __metrics Screen width/height:1600/1200 12:32:40 INFO - PROCESS | 18155 | colorDepth:24 12:32:40 INFO - PROCESS | 18155 | Browser inner width/height: 1024/697 12:32:40 INFO - PROCESS | 18155 | __metrics 12:32:41 INFO - PROCESS | 18155 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:32:42 INFO - TEST-INFO | 18155: exit 0 12:32:42 INFO - Browser initialized. 12:32:42 INFO - Running cycle 1/1 for kraken test... 12:32:42 INFO - TEST-INFO | started process 18240 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptZSgPj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:32:54 INFO - PROCESS | 18240 | RSS: Main: 159064064 12:32:54 INFO - PROCESS | 18240 | 12:32:56 INFO - PROCESS | 18240 | Cycle 1(1): loaded http://localhost:52643/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52643/tests/kraken/driver.html?testName=audio-beat-detection) 12:32:57 INFO - PROCESS | 18240 | RSS: Main: 216731648 12:32:57 INFO - PROCESS | 18240 | 12:33:00 INFO - PROCESS | 18240 | Cycle 1(1): loaded http://localhost:52643/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52643/tests/kraken/driver.html?testName=audio-dft) 12:33:01 INFO - PROCESS | 18240 | RSS: Main: 202948608 12:33:01 INFO - PROCESS | 18240 | 12:33:04 INFO - PROCESS | 18240 | Cycle 1(1): loaded http://localhost:52643/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52643/tests/kraken/driver.html?testName=audio-fft) 12:33:04 INFO - PROCESS | 18240 | RSS: Main: 271196160 12:33:04 INFO - PROCESS | 18240 | 12:33:07 INFO - PROCESS | 18240 | Cycle 1(1): loaded http://localhost:52643/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52643/tests/kraken/driver.html?testName=audio-oscillator) 12:33:07 INFO - PROCESS | 18240 | RSS: Main: 181211136 12:33:07 INFO - PROCESS | 18240 | 12:33:09 INFO - PROCESS | 18240 | Cycle 1(1): loaded http://localhost:52643/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52643/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:33:10 INFO - PROCESS | 18240 | RSS: Main: 185815040 12:33:10 INFO - PROCESS | 18240 | 12:33:13 INFO - PROCESS | 18240 | Cycle 1(1): loaded http://localhost:52643/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52643/tests/kraken/driver.html?testName=imaging-darkroom) 12:33:14 INFO - PROCESS | 18240 | RSS: Main: 222498816 12:33:14 INFO - PROCESS | 18240 | 12:33:17 INFO - PROCESS | 18240 | Cycle 1(1): loaded http://localhost:52643/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52643/tests/kraken/driver.html?testName=imaging-desaturate) 12:33:18 INFO - PROCESS | 18240 | RSS: Main: 217571328 12:33:18 INFO - PROCESS | 18240 | 12:33:21 INFO - PROCESS | 18240 | Cycle 1(1): loaded http://localhost:52643/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52643/tests/kraken/driver.html?testName=json-parse-financial) 12:33:22 INFO - PROCESS | 18240 | RSS: Main: 220663808 12:33:22 INFO - PROCESS | 18240 | 12:33:23 INFO - PROCESS | 18240 | Cycle 1(1): loaded http://localhost:52643/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52643/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:33:24 INFO - PROCESS | 18240 | RSS: Main: 207220736 12:33:24 INFO - PROCESS | 18240 | 12:33:26 INFO - PROCESS | 18240 | Cycle 1(1): loaded http://localhost:52643/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52643/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:33:26 INFO - PROCESS | 18240 | RSS: Main: 211902464 12:33:26 INFO - PROCESS | 18240 | 12:33:28 INFO - PROCESS | 18240 | Cycle 1(1): loaded http://localhost:52643/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52643/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:33:29 INFO - PROCESS | 18240 | RSS: Main: 210345984 12:33:29 INFO - PROCESS | 18240 | 12:33:32 INFO - PROCESS | 18240 | Cycle 1(1): loaded http://localhost:52643/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52643/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:33:32 INFO - PROCESS | 18240 | RSS: Main: 222236672 12:33:32 INFO - PROCESS | 18240 | 12:33:35 INFO - PROCESS | 18240 | Cycle 1(1): loaded http://localhost:52643/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52643/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:33:36 INFO - PROCESS | 18240 | RSS: Main: 223694848 12:33:36 INFO - PROCESS | 18240 | 12:33:38 INFO - PROCESS | 18240 | Cycle 1(1): loaded http://localhost:52643/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52643/tests/kraken/driver.html?testName=ai-astar) 12:33:38 INFO - PROCESS | 18240 | RSS: Main: 266366976 12:33:38 INFO - PROCESS | 18240 | 12:33:38 INFO - PROCESS | 18240 | __start_tp_report 12:33:38 INFO - PROCESS | 18240 | _x_x_mozilla_page_load 12:33:38 INFO - PROCESS | 18240 | _x_x_mozilla_page_load_details 12:33:38 INFO - PROCESS | 18240 | |i|pagename|runs| 12:33:38 INFO - PROCESS | 18240 | |0;ai-astar;106;115;113;114;115;113;114;115;115;114 12:33:38 INFO - PROCESS | 18240 | |1;audio-beat-detection;145;122;129;175;123;124;150;125;156;124 12:33:38 INFO - PROCESS | 18240 | |2;audio-dft;165;162;161;161;162;162;162;160;161;161 12:33:38 INFO - PROCESS | 18240 | |3;audio-fft;76;76;75;124;76;76;73;75;98;75 12:33:38 INFO - PROCESS | 18240 | |4;audio-oscillator;84;85;125;86;92;85;122;84;84;125 12:33:38 INFO - PROCESS | 18240 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;116;117;117 12:33:38 INFO - PROCESS | 18240 | |6;imaging-darkroom;147;146;146;146;148;148;147;147;146;147 12:33:38 INFO - PROCESS | 18240 | |7;imaging-desaturate;96;94;94;95;94;95;95;95;95;94 12:33:38 INFO - PROCESS | 18240 | |8;json-parse-financial;64;64;63;64;64;73;64;64;65;64 12:33:38 INFO - PROCESS | 18240 | |9;json-stringify-tinderbox;65;66;66;65;65;65;80;65;65;65 12:33:38 INFO - PROCESS | 18240 | |10;stanford-crypto-aes;79;89;78;79;78;78;78;78;78;79 12:33:38 INFO - PROCESS | 18240 | |11;stanford-crypto-ccm;130;146;129;126;128;128;128;128;172;127 12:33:38 INFO - PROCESS | 18240 | |12;stanford-crypto-pbkdf2;167;169;168;166;168;166;169;168;165;165 12:33:38 INFO - PROCESS | 18240 | |13;stanford-crypto-sha256-iterative;68;67;68;67;70;67;68;69;71;65 12:33:38 INFO - PROCESS | 18240 | __end_tp_report 12:33:38 INFO - PROCESS | 18240 | __start_cc_report 12:33:38 INFO - PROCESS | 18240 | _x_x_mozilla_cycle_collect,1914 12:33:38 INFO - PROCESS | 18240 | __end_cc_report 12:33:38 INFO - PROCESS | 18240 | __startTimestamp1467401618484__endTimestamp 12:33:38 INFO - PROCESS | 18240 | 12:33:38 INFO - PROCESS | 18240 | ------- Summary: start ------- 12:33:38 INFO - PROCESS | 18240 | Number of tests: 14 12:33:38 INFO - PROCESS | 18240 | 12:33:38 INFO - PROCESS | 18240 | [#0] ai-astar Cycles:10 Average:113.40 Median:114.50 stddev:2.72 (2.4%) stddev-sans-first:0.83 12:33:38 INFO - PROCESS | 18240 | Values: 106.0 115.0 113.0 114.0 115.0 113.0 114.0 115.0 115.0 114.0 12:33:38 INFO - PROCESS | 18240 | 12:33:38 INFO - PROCESS | 18240 | [#1] audio-beat-detection Cycles:10 Average:137.30 Median:137.00 stddev:18.27 (13.3%) stddev-sans-first:19.16 12:33:38 INFO - PROCESS | 18240 | Values: 145.0 122.0 129.0 175.0 123.0 124.0 150.0 125.0 156.0 124.0 12:33:38 INFO - PROCESS | 18240 | 12:33:38 INFO - PROCESS | 18240 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.34 (0.8%) stddev-sans-first:0.71 12:33:38 INFO - PROCESS | 18240 | Values: 165.0 162.0 161.0 161.0 162.0 162.0 162.0 160.0 161.0 161.0 12:33:38 INFO - PROCESS | 18240 | 12:33:38 INFO - PROCESS | 18240 | [#3] audio-fft Cycles:10 Average:82.40 Median:76.00 stddev:16.30 (21.4%) stddev-sans-first:17.12 12:33:38 INFO - PROCESS | 18240 | Values: 76.0 76.0 75.0 124.0 76.0 76.0 73.0 75.0 98.0 75.0 12:33:38 INFO - PROCESS | 18240 | 12:33:38 INFO - PROCESS | 18240 | [#4] audio-oscillator Cycles:10 Average:97.20 Median:84.50 stddev:18.66 (22.1%) stddev-sans-first:19.17 12:33:38 INFO - PROCESS | 18240 | Values: 84.0 85.0 125.0 86.0 92.0 85.0 122.0 84.0 84.0 125.0 12:33:38 INFO - PROCESS | 18240 | 12:33:38 INFO - PROCESS | 18240 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 12:33:38 INFO - PROCESS | 18240 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 116.0 117.0 117.0 12:33:38 INFO - PROCESS | 18240 | 12:33:38 INFO - PROCESS | 18240 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 12:33:38 INFO - PROCESS | 18240 | Values: 147.0 146.0 146.0 146.0 148.0 148.0 147.0 147.0 146.0 147.0 12:33:38 INFO - PROCESS | 18240 | 12:33:38 INFO - PROCESS | 18240 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.53 12:33:38 INFO - PROCESS | 18240 | Values: 96.0 94.0 94.0 95.0 94.0 95.0 95.0 95.0 95.0 94.0 12:33:38 INFO - PROCESS | 18240 | 12:33:38 INFO - PROCESS | 18240 | [#8] json-parse-financial Cycles:10 Average:64.90 Median:64.00 stddev:2.88 (4.5%) stddev-sans-first:3.04 12:33:38 INFO - PROCESS | 18240 | Values: 64.0 64.0 63.0 64.0 64.0 73.0 64.0 64.0 65.0 64.0 12:33:38 INFO - PROCESS | 18240 | 12:33:38 INFO - PROCESS | 18240 | [#9] json-stringify-tinderbox Cycles:10 Average:66.70 Median:65.00 stddev:4.69 (7.2%) stddev-sans-first:4.94 12:33:38 INFO - PROCESS | 18240 | Values: 65.0 66.0 66.0 65.0 65.0 65.0 80.0 65.0 65.0 65.0 12:33:38 INFO - PROCESS | 18240 | 12:33:38 INFO - PROCESS | 18240 | [#10] stanford-crypto-aes Cycles:10 Average:79.40 Median:78.50 stddev:3.41 (4.3%) stddev-sans-first:3.61 12:33:38 INFO - PROCESS | 18240 | Values: 79.0 89.0 78.0 79.0 78.0 78.0 78.0 78.0 78.0 79.0 12:33:38 INFO - PROCESS | 18240 | 12:33:38 INFO - PROCESS | 18240 | [#11] stanford-crypto-ccm Cycles:10 Average:134.20 Median:128.50 stddev:14.47 (11.3%) stddev-sans-first:15.27 12:33:38 INFO - PROCESS | 18240 | Values: 130.0 146.0 129.0 126.0 128.0 128.0 128.0 128.0 172.0 127.0 12:33:38 INFO - PROCESS | 18240 | 12:33:38 INFO - PROCESS | 18240 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.10 Median:168.00 stddev:1.52 (0.9%) stddev-sans-first:1.62 12:33:38 INFO - PROCESS | 18240 | Values: 167.0 169.0 168.0 166.0 168.0 166.0 169.0 168.0 165.0 165.0 12:33:38 INFO - PROCESS | 18240 | 12:33:38 INFO - PROCESS | 18240 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.00 stddev:1.70 (2.5%) stddev-sans-first:1.80 12:33:38 INFO - PROCESS | 18240 | Values: 68.0 67.0 68.0 67.0 70.0 67.0 68.0 69.0 71.0 65.0 12:33:38 INFO - PROCESS | 18240 | -------- Summary: end -------- 12:33:38 INFO - PROCESS | 18240 | 12:33:39 INFO - TEST-INFO | 18240: exit 0 12:33:39 INFO - TEST-OK | kraken | took 63789ms 12:33:39 INFO - SUITE-END | took 1183s 12:33:39 INFO - Completed test suite (00:19:44) 12:33:39 INFO - javascript benchmark 12:33:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2602.1803132013415, 2623.501534708404, 2646.788256939445, 2665.6268122462857, 2668.1061844282162, 4567.292069729189, 4620.2838560023165, 4735.952640473599, 4779.90440191196, 4802.951970480294, 4675.602573781224, 4687.789049492772, 4702.3651807006045, 4727.4563425206115, 4731.503192164825, 4085.428040074392, 4239.724417912841, 4340.67444941629, 4359.585839345257, 4439.977800110995, 4362.541933097027, 4403.713758605696, 4411.073674528337, 4425.0, 4456.153330867141, 4242.278812601834, 4288.571142885718, 4310.547392523803, 4356.194104090753, 4364.018095928391, 4262.65898728101, 4270.145970805851, 4277.337012763027, 4314.094040251551, 4346.043870348518, 4300.806463709109, 4317.4819021717285, 4324.0, 4357.891052723676, 4359.0, 4557.9772101139615, 4640.211164102111, 4670.743109128996, 4699.483056863776, 4706.5293470653005, 5102.336696229503, 5122.129238029544, 5126.256692779563, 5128.358955130609, 5140.203268493389, 5090.38915330159, 5142.742862856842, 5156.226566015128, 5170.741462926839, 5171.922421163686, 4605.424321959755, 4667.043256132485, 4683.976580117146, 4734.644901632322, 4738.3129446230105, 5191.792328306826, 5246.213068039749, 5250.369955605275, 5255.474452554714, 5256.211568264791, 4822.107910036654, 4983.377077865267, 4986.0, 4993.1262029144755, 5040.697558146449, 4977.875553111201, 5020.397552293675, 5020.548150666385, 5045.217991211368, 5109.029284435946, 4997.600191984705, 5001.44984051754, 5002.674826136289, 5008.223725322581, 5057.822976195889, 4863.440704318978, 4972.776225069881, 5008.273800298936, 5012.649114561946, 5062.341895553554, 4212.220739163265, 4232.280512312914, 4274.615284624399, 4293.957060429419, 4335.544767799399, 3741.102135487518, 3750.6999440044733, 3755.080005398695, 3786.2995345861104, 3799.430085487199, 4362.236608593484, 4362.454693163355, 4371.169477799208, 4413.713108647928, 4413.955860441419, 4939.2838038484215, 4981.850544483671, 4987.526185012418, 5014.473480284518, 5045.445001049881, 4347.174036932973, 4355.499117601516, 4355.869323920288, 4370.672199585044, 4407.581279778416, 4539.024109816405, 4541.863744087683, 4543.931841022388, 4547.226971414867, 4598.540145985375, 4629.305604159335, 4684.882877928079, 4725.692829966041, 4738.265568836836, 4777.665563410528, 5064.721440320818, 5085.0338435697095, 5092.567131793691, 5100.897982040413, 5138.409082955359, 4607.6313894889, 4729.196036673705, 4759.690620109682, 4759.904801903874, 4799.0401919615515, 4910.337104490848, 4922.064807686528, 4940.654154209171, 4969.031038947371, 4974.5771609413605, 5021.623378246573, 5042.168042272984, 5043.2687260347775, 5047.343845300087, 5090.821821236239, 4805.495422980537, 4851.29656199842, 4877.512248775236, 4883.194272944925, 4918.754062296943, 4907.484714104968, 4942.159832828356, 4973.875653108701, 4974.900501990012, 5016.6237532184505, 4885.828995985124, 4892.877678057935, 4897.975510122569, 4942.901141977212, 4955.0, 4806.399200099988, 4879.780409881493, 4932.605391568594, 4992.825251116194, 5036.874078148076, 4716.844373128605, 4725.574698277172, 4762.14281429346, 4763.071201115749, 4775.6657034007285], "value": 4630.208615624306, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [540.33722914335, 585.4204337705671, 590.6898878089005, 590.881823635273, 592.8428966323924, 39986.80006599967, 40315.395269070985, 40993.0, 41173.0, 41454.37818432722, 37256.0, 41333.7933310333, 41479.79260103703, 41533.0, 41572.0, 7538.9246107538775, 7875.0, 8013.879791803128, 8027.076886158079, 10294.227932905025, 9991.90008099917, 10430.0, 10466.215033872451, 10468.94765526175, 10471.947640261787, 10422.478876056166, 10505.369677819355, 10517.211209159306, 10575.682729518088, 10579.84130238047, 10364.429956352398, 10418.687439376756, 10474.376471646907, 10479.58081676732, 10480.895191048068, 10346.896531034668, 10409.79180416395, 10414.323069000491, 10418.218633602435, 10418.531166097468, 39817.80091099555, 40188.79905600454, 40231.19537609231, 40380.192396152204, 40381.59618403837, 3096.194989302775, 3103.3948380065895, 3141.356022015504, 3205.487122060459, 3365.1418888183603, 30537.389252215053, 30690.38619227625, 31021.84489077563, 31317.37365252682, 31360.21599460009, 3318.1538707629643, 3334.2664613785173, 3353.865845366207, 3354.37943980362, 3374.6962773350515, 257742.0, 261855.0, 262181.0, 263480.9999999981, 264047.0, 57374.139387909214, 57735.71132144312, 57823.710881445324, 57844.0, 57999.0, 62214.37785622176, 62254.0661890072, 62290.68854655788, 62311.688441557504, 62338.68830655818, 15181.316840742193, 15474.690506190038, 15478.226088695521, 15486.380544778309, 15487.457938972308, 10467.790644187226, 11261.099112071015, 11330.830037549444, 11355.60255391074, 11809.40952952349, 19119.0, 19172.233110675417, 19189.0, 19191.232350705814, 19250.422487325122, 5681.886362272731, 6933.757318493828, 7184.892226616605, 7195.496315257987, 7270.527415717961, 820.4052062254817, 912.7991841794794, 933.2021121940643, 975.2490582251627, 1018.3410352803652, 28062.719372806012, 28155.0, 28564.857175714405, 29064.418711626073, 29192.854035729684, 969.1568335548118, 992.1021475564626, 1018.974525636865, 1049.559185142242, 1075.870895492546, 14900.403983840743, 15067.623309417353, 15368.923155384151, 15660.0, 15701.214939252992, 376023.0, 376631.0, 379683.0, 380551.0, 381668.0, 49432.50567494351, 49695.50304496981, 49986.0, 50032.49967500351, 50062.749686251336, 1082.355998181081, 1121.8092924202742, 1181.4092953523239, 1195.9521619135137, 1211.8848709372596, 27098.593521096805, 29161.56257656179, 29419.585732565374, 29519.0, 29963.250918727208, 41568.376474352306, 41930.37104443497, 41948.0, 41985.16029679451, 42015.0, 243511.0, 248065.0, 249656.0, 250919.0, 251075.0, 32838.67161328452, 36526.08684782795, 37839.810800945816, 39150.412743808294, 42059.579404206794, 41984.79007604942, 42477.78761106174, 42645.57354426416, 42870.57129428666, 43610.0, 36213.63786362103, 36490.8175459121, 36598.8170059148, 36768.0, 37009.07477313089, 34745.30509389748, 37739.245215096096, 37965.620343797316, 38111.42832857565, 38125.237495249385, 36759.63240367562, 37476.06309842167, 37707.0, 37728.81135594304, 37881.0, 32453.51319730253, 33668.83165584156, 33843.323133537684, 34380.0, 34529.654703452645, 25304.240872773848, 25722.485550288515, 25842.68542071969, 26115.369740482452, 26240.73759262383], "value": 18637.610616598464, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.48522701175256, 359.7373917040562, 368.2744992365041, 370.82200543739003, 382.33473755665136, 12980.286084265374, 16575.088370139638, 16893.07088110155, 17561.91219043903, 18470.261189552402, 16931.407400740976, 16999.405020824273, 17122.40071597494, 17551.82448175521, 17668.204930778113, 5100.081985242655, 5256.474352564732, 5539.058360078776, 5544.695041772701, 5595.104783234683, 3488.1802776347663, 5420.430854760252, 5512.366077901052, 5667.149927510885, 5681.687507187103, 5707.229524014247, 5723.4848863602265, 5746.281714785652, 5750.7412166452405, 5752.942470575283, 5369.812056578021, 5461.344638643388, 5469.507744302992, 5469.890602187974, 5469.972650136724, 3399.354122716676, 5163.870903227412, 5269.314989051437, 5459.454054594548, 5465.180222966547, 12445.688857778538, 12548.874511254862, 12652.304123273216, 14568.781468277984, 20855.0, 1927.9036048197675, 1943.5335519475366, 1950.7268982342484, 2077.0, 2422.6123820188686, 8950.59722312491, 9449.43303401798, 9454.669086581936, 12229.449674764657, 12637.988960883107, 1760.0935518208132, 1772.3176577017812, 1778.6798376292263, 1810.2849374497, 1844.4190080124852, 60300.69849650723, 67172.0, 68261.65869170672, 68667.31332686658, 69034.30965690379, 8943.3739638226, 9437.57530911097, 10050.0, 10133.493325333704, 10179.338343007681, 12734.554290599785, 13578.524751633842, 13582.0, 13913.513027044004, 14007.929960350337, 6787.966060169668, 7102.751403700846, 7162.570245785269, 7365.2634736525915, 7462.925370746331, 7033.226345102034, 7065.328793764585, 7142.357187853118, 7214.350708436266, 7262.455315851333, 4355.206410926981, 4361.80371883266, 4395.802188901507, 4445.844395446144, 4473.4408198975125, 1777.9644407111784, 1808.264066496152, 1824.6077093424976, 1836.2287839107607, 1883.2843519462517, 778.7040924448673, 871.5163084488044, 888.626776753765, 896.7399454158221, 898.7842917699836, 16750.413735519443, 17188.0, 17572.648547028988, 17751.55575879273, 17889.910550447163, 839.2111415269749, 852.1691350932915, 870.8127752533236, 878.6968495868915, 913.5614904845578, 9450.0, 10244.795104097877, 10266.435346055889, 10562.313449625903, 10629.627963021412, 319539.0, 322998.0, 326440.0, 422757.0, 425370.0, 81542.28361323637, 88921.0, 89205.55397223102, 89259.0, 89810.0, 919.5034681272172, 940.7742141885898, 943.2501161576427, 944.9480278584743, 946.6118891254553, 16056.718905137383, 16188.190590470194, 16325.59186020359, 16573.17134143312, 16742.0, 31223.531647025768, 34233.0, 38629.02261035946, 39072.6092739069, 39759.2048159041, 51687.0, 52439.0, 54774.17838732502, 55117.44882551123, 56703.0, 7522.0, 7842.372610191057, 7936.563489007929, 7953.204679532, 8020.398470114648, 8937.865932011155, 10937.671869843918, 11346.829797553208, 11885.28688278706, 12497.37513124322, 9826.16477599412, 10303.587856485656, 10353.585856565653, 10364.959132960103, 10439.269251152346, 10410.531526081497, 10552.419616921143, 10732.087772539422, 10770.838437423288, 10788.190885683762, 10320.948395257976, 10573.101286390436, 10758.13934885223, 10873.0, 11020.283681560673, 7796.220377962159, 7832.530048196899, 7872.527648341118, 7879.0, 7933.8413231736195, 8569.657213711382, 10441.216908731723, 10541.683749487527, 10710.892891071302, 10711.732206694895], "value": 8254.737079151408, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1269.7016201192723, 1374.7387996280706, 1443.7040406716621, 1506.4877941499888, 1714.2486956261741, 6867.244603093655, 7603.543787372754, 7863.882041769378, 7883.369330453572, 8145.104038555754, 7911.802204944879, 8074.273315401612, 8091.3526917846575, 8097.190280971915, 8103.149169337223, 2195.3962660268435, 2230.319752475494, 2234.106357457014, 2234.229190929135, 2235.0836157175563, 2173.2285038811233, 2195.626743453609, 2219.833512486562, 2222.144474377368, 2226.899789509468, 2193.0679461228992, 2195.9560808783813, 2203.1407750977132, 2203.283932721864, 2239.4625289930464, 2156.2884248198134, 2162.3945295317335, 2163.1131236193087, 2164.199246278879, 2165.07984106754, 2105.1789801977243, 2145.0776166248506, 2146.4848436375314, 2147.95704085919, 2149.3014770199748, 7929.484583502054, 8036.919630803675, 8041.0, 8055.879161812519, 8186.631601577943, 4461.754603496806, 4579.977100114478, 4588.059447813223, 4594.954050459486, 4600.240960241556, 2843.2039029071893, 3039.285767844555, 3053.7709671774705, 3084.290613158986, 3091.134482344947, 925.1673493855517, 925.8333499970003, 939.9671011514564, 948.9905100948971, 952.1002652493396, 10887.237893347468, 10967.780644387147, 10978.066864316543, 10994.34033957957, 10995.450227488673, 3953.3000809652126, 4110.938335924963, 4114.958850411517, 4140.937885931713, 4288.764117973541, 8473.703420380258, 8562.0, 8569.143085691505, 8584.442011269248, 8589.184027517376, 4440.0, 4441.622462090694, 4444.4888837784065, 4447.155040542287, 4447.933281000787, 3677.669009789132, 3993.9201215975518, 4118.670506359484, 4124.360724087771, 4150.481189851269, 3479.8608055677996, 3507.316073365669, 3509.3156834417555, 3596.7482276240935, 3613.060604242916, 1015.7968406318765, 1033.6278939581744, 1038.08129805123, 1040.2198351236573, 1048.444324508012, 674.6963866260203, 821.7863355527486, 835.6114406800867, 838.3837879158814, 856.4005196362447, 5078.7460626968505, 5155.7679904404395, 5249.606279529051, 5285.497877701612, 5321.148616221386, 393.36471598369, 393.55921368067374, 398.5496389080321, 427.26510402108323, 434.13606922224545, 3536.398812201932, 3644.7630903991158, 3675.2649470106085, 3684.447332900033, 3684.5394325709285, 9688.273379496566, 10046.29675922693, 10064.69805905824, 10162.288639795292, 10167.4916254187, 10042.69871903844, 10062.19502439803, 10087.092161705481, 10107.949460252652, 10110.090091891765, 7501.437392195608, 7594.354479869163, 7668.233176682287, 7685.077790665044, 7700.114486833973, 5085.338905942203, 5106.412762532356, 5133.07604631155, 5153.149730294459, 5185.766640501111, 9137.63449462014, 9179.127982841619, 9241.86137207929, 9311.86032209531, 9362.625494980124, 9244.537773111451, 9471.47906865129, 9490.383125096847, 9586.66446674363, 9588.76028099303, 5957.374475680164, 6089.0, 6149.969250153899, 6631.701573429111, 6704.094947182068, 7212.89180662301, 7442.479026468095, 7456.589887556236, 7651.234876512304, 7652.196519365609, 6508.967455162883, 6634.734610615715, 6646.102776125162, 6714.630695311805, 6770.729170833111, 6515.250746164252, 6555.3772391622715, 6570.277269500447, 6629.0, 6712.966435167793, 5861.6189947653265, 5868.589198756217, 5905.232319798571, 5914.378990205966, 5914.674692891932, 4243.596858298457, 4308.202982448257, 4356.586124318184, 4395.296752519582, 4434.068845542472, 4385.868423947287, 4427.29163333865, 4465.754383508808, 4477.059817438374, 4517.954820451753], "value": 4029.7630232877054, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.8272319331594, 301.5446675519965, 306.5845778969496, 309.313324419788, 311.1179805252112, 4818.530657926296, 4825.638077144211, 4844.467108618053, 4853.635977301703, 4884.975575122119, 4779.856604301876, 4788.186008378575, 4792.562231330596, 4798.928016079762, 4800.399950006249, 3577.481265216542, 3711.443283507482, 3719.163188282642, 3727.589965103836, 3742.2141350316465, 3641.7814931104085, 3746.7939263340504, 3811.7331786774935, 3822.808859557011, 3829.48301979232, 3709.5733990591025, 3761.153740408414, 3774.5279341057008, 3775.528058992626, 3785.7728536287773, 3523.5553423096408, 3741.5323084614424, 3762.8118594070324, 3792.50697409335, 3818.102745854722, 3277.8033318001, 3281.6226133994655, 3283.3925723740945, 3288.128645908836, 3293.4730443129224, 4728.1252968201, 4728.40894888139, 4763.857084287477, 4766.142094423002, 4768.403949506312, 4267.530571637118, 4270.402143699885, 4292.527821939615, 4302.913941721179, 4314.525402205755, 4914.066327397783, 5012.298278241049, 5021.096202683516, 5037.647364684437, 5088.440271570124, 3568.8750893718857, 3584.22939068099, 3598.1364472526666, 3604.3960437605274, 3609.8736544221088, 5209.973950130225, 5227.320448341729, 5234.842954711365, 5243.239730239132, 5256.369235691704, 3562.8931132066077, 3693.9815300923324, 3697.815109244581, 3705.166337574024, 3708.8331025103935, 3706.5552133744122, 3731.272401881607, 3738.345789486829, 3743.3636281832155, 3751.437284407361, 4260.10537787062, 4271.337942618837, 4271.8466014176, 4272.316429371285, 4274.610751505773, 4919.36048313724, 5017.698938063655, 5066.113430149783, 5066.859956509756, 5071.391433027987, 1269.6825793551611, 1291.2446218961825, 1291.7351942851692, 1293.2822283632674, 1295.7538067767093, 813.4671789977574, 819.148085990575, 819.7827575692446, 826.7933016745814, 839.6305625524872, 4331.913361732748, 4496.797644106023, 4513.277875539898, 4516.570925762047, 4516.8193272268745, 5185.403678576937, 5189.896202075937, 5204.739763011834, 5224.425313215544, 5272.314599102092, 4386.2762644163995, 4479.55204479556, 4481.708688935209, 4493.707908985905, 4532.388127602731, 2718.9803823566162, 2752.683441404224, 2773.791965602588, 2782.1375373634237, 2782.5547912333927, 4909.1654418748185, 4916.115099282092, 4922.261660750844, 4922.680025798311, 4950.777215025332, 5185.807264329225, 5233.685978841282, 5307.575393968474, 5309.973450132725, 5351.304330437096, 4875.414950205998, 4897.216445368724, 4898.314236006961, 4915.877103072452, 4916.483769204254, 5231.913171228841, 5238.930622404206, 5255.290535777774, 5305.814296499604, 5309.681419114865, 4778.952210477851, 5057.949420505748, 5072.4673909239, 5088.771005304696, 5164.664296820694, 4886.315915771724, 4888.7311197884455, 4914.70511769295, 4918.729469879191, 4924.335214745964, 3696.7042636589545, 3727.720420968384, 3733.0480727414338, 3737.3646480097905, 3749.2501499700716, 5199.246109314053, 5295.4581800735095, 5301.469853014668, 5309.973450132725, 5314.415414304501, 5058.3929928408825, 5064.46823083571, 5094.184930411265, 5101.9489805101475, 5131.204663277198, 4998.2502624606595, 5046.924296135634, 5052.8989420210655, 5054.59563234933, 5100.336956195819, 4774.21225497789, 4975.830679790319, 4985.950140498694, 4988.501149884983, 5000.824971126139, 4836.830710925101, 4957.3059771632725, 4975.5522003019905, 4977.228529577921, 5118.129917913889, 4851.56335929768, 4895.216765317532, 5000.1749711297225, 5023.146065169003, 5027.723475208899], "value": 3808.444419283826, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [639.6418005916687, 663.6117871045436, 690.078744875591, 715.2061212054622, 740.3336996702967, 12847.678808029805, 13701.657458563515, 13863.514776982807, 13869.861301386984, 13881.028328017055, 12758.298293593849, 13483.528076517325, 13488.325583720823, 13499.122557033787, 13515.797263041062, 627.5199472403615, 743.9814004649886, 755.1466842468031, 771.5717776633966, 790.8062524681461, 656.3666062249928, 672.7645324136562, 673.168636733636, 673.2157037051828, 673.2190658835751, 844.1895780051158, 848.6138806842903, 848.8684253940618, 849.2399302624148, 849.7875531117221, 637.5791977294987, 796.5618909599755, 829.5810615639064, 841.247083859945, 841.7011960753936, 606.9635821850659, 609.9329073801878, 609.9908501372483, 610.3713175429315, 610.5207412181461, 12279.508819647204, 12357.011439084852, 12369.69075773104, 12382.257064576153, 12453.688657783538, 11375.829362559569, 12368.690782730413, 12797.808032879515, 12828.273258973806, 13179.0, 11196.944015279953, 11237.775244495064, 11570.190086693934, 11616.94191529037, 12322.445489952885, 4163.10493243951, 4165.271077561445, 4242.7242229255, 4371.934420983688, 4374.956250437519, 59935.70032149855, 61459.69270153665, 61459.77080458411, 61658.075128873104, 61768.69115654438, 9646.641701856548, 9727.221822254203, 9759.560819763128, 9767.072128147815, 10149.492525373702, 14538.127712337293, 14609.123452592667, 14666.486672966608, 14667.04664196845, 14691.118532887847, 6384.3934826191435, 6730.730770769114, 6764.458843292525, 6900.930990690129, 6958.434352270699, 3650.452432135148, 3711.925761484755, 3744.8876533704033, 3802.885913422602, 3938.9212215755524, 2714.7013828478853, 2800.719928007183, 2805.5370863807652, 2806.2843974786297, 2808.424273024066, 509.969401835891, 512.1753976098479, 522.6002108387087, 528.9603279754034, 572.2103497173873, 595.4611076975344, 609.6707777800027, 617.3826173826174, 625.3090335179652, 637.9362063793584, 8094.473859199134, 8684.60919258635, 8820.514871682119, 8836.734897953073, 8893.155150260714, 616.4513582911212, 627.4917316973266, 630.4735545819201, 630.9242591872687, 636.0681601453892, 4011.4584531088512, 4041.636252737209, 4074.3888416737727, 4184.497860256789, 4220.134872351161, 58246.12630810541, 72685.63657181681, 96940.51529742306, 105785.0, 107122.46438767757, 54667.0, 72662.27337726661, 79466.0, 88341.55829220942, 88991.0, 79821.0, 80632.0, 84965.15034849572, 85073.57463212768, 85106.14893851106, 7851.568163751049, 7955.960220198862, 8081.757547273592, 8091.595420229083, 8247.21651443112, 33558.3288334227, 38431.61568384281, 38937.73551049762, 40609.36039157445, 41395.58604413917, 59419.1087133702, 60197.699011504665, 61135.0, 61208.69395652993, 63022.36977630165, 11087.611933582286, 11206.607768728381, 11276.605318813803, 11359.659210223706, 11596.826047609462, 12338.259704417764, 12386.62840114798, 12494.500219991098, 12689.492420303084, 12958.874826439227, 11867.940660296988, 11916.582919597773, 12363.134580579273, 12393.504259829506, 12771.872281277068, 11530.711732206762, 11642.41787910618, 11770.646880593597, 11825.940870295593, 12541.247525148521, 11251.38117403518, 11361.320358862642, 11990.160688751703, 12149.331786751813, 12847.871521284667, 9938.10557049869, 9946.900530994597, 10087.596496140071, 10110.292279540361, 10524.52639631203, 9782.951085244527, 10248.53881575316, 10290.0, 10319.122874555747, 10345.586176552853], "value": 6549.255337585203, "unit": "score"}], "name": "dromaeo_css", "value": 6444.082463314855, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 115.0, 113.0, 114.0, 115.0, 113.0, 114.0, 115.0, 115.0, 114.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 122.0, 129.0, 175.0, 123.0, 124.0, 150.0, 125.0, 156.0, 124.0], "value": 137.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 162.0, 161.0, 161.0, 162.0, 162.0, 162.0, 160.0, 161.0, 161.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 124.0, 76.0, 76.0, 73.0, 75.0, 98.0, 75.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 125.0, 86.0, 92.0, 85.0, 122.0, 84.0, 84.0, 125.0], "value": 97.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 148.0, 148.0, 147.0, 147.0, 146.0, 147.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 94.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 63.0, 64.0, 64.0, 73.0, 64.0, 64.0, 65.0, 64.0], "value": 64.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 65.0, 65.0, 65.0, 80.0, 65.0, 65.0, 65.0], "value": 66.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 89.0, 78.0, 79.0, 78.0, 78.0, 78.0, 78.0, 78.0, 79.0], "value": 79.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 146.0, 129.0, 126.0, 128.0, 128.0, 128.0, 128.0, 172.0, 127.0], "value": 134.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 169.0, 168.0, 166.0, 168.0, 166.0, 169.0, 168.0, 165.0, 165.0], "value": 167.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 68.0, 67.0, 70.0, 67.0, 68.0, 69.0, 71.0, 65.0], "value": 68.0, "unit": "score"}], "name": "kraken", "value": 1530.6, "alertThreshold": 2.0}]} 12:33:39 INFO - Return code: 0 12:33:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:33:39 INFO - # TBPL SUCCESS # 12:33:39 INFO - Running post-action listener: _resource_record_post_action 12:33:39 INFO - ##### 12:33:39 INFO - ##### Finished run-tests step (success) 12:33:39 INFO - ##### 12:33:39 INFO - Running post-run listener: _resource_record_post_run 12:33:39 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 0; Write bytes: 545902592; Read time: 0; Write time: 530248 12:33:39 INFO - TinderboxPrint: CPU usage
13.0% 12:33:39 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 12:33:39 INFO - TinderboxPrint: I/O write bytes / time
545,902,592 / 530,248 12:33:39 INFO - TinderboxPrint: CPU idle
8,341.8 (87.0%) 12:33:39 INFO - TinderboxPrint: CPU user
1,200.9 (12.5%) 12:33:39 INFO - TinderboxPrint: Swap in / out
0 / 0 12:33:39 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 257888256; Read time: 0; Write time: 303720 12:33:39 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 288014336; Read time: 0; Write time: 226528 12:33:40 INFO - Running post-run listener: _upload_blobber_files 12:33:40 INFO - Blob upload gear active. 12:33:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:33:40 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 12:33:40 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:33:40 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:33:40 INFO - (blobuploader) - INFO - Open directory for files ... 12:33:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:33:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:33:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:33:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:33:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:33:41 INFO - (blobuploader) - INFO - Done attempting. 12:33:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:33:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:33:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:33:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:33:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:33:42 INFO - (blobuploader) - INFO - Done attempting. 12:33:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:33:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:33:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:33:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:33:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:33:45 INFO - (blobuploader) - INFO - Done attempting. 12:33:45 INFO - (blobuploader) - INFO - Iteration through files over. 12:33:45 INFO - Return code: 0 12:33:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:33:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:33:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/645118950a34fed42f3dc10b9d5602555f154ddb7ac17beb9ac342d499fb4e21c5e004a0f10aa4a65a85adae14798d41ceb5916fc96c75f92c3ae82d12969b93", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/965fe2fc522fda06e61d7e245ec2328275ab16c51127e9ea03a1ffdfadb975587785c269464cabcff42d49b70b35d7b625ff227a3e042f73a47d1c223e69b108", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/214d061f210e38fa94afaeee89a7391fd3936f6dbbf202c9a9e06cfe46df75d8c0055003dfe10e11c1707bc6664378d978457644fb45dcdfdf41be9267038d27"} 12:33:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:33:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:33:45 INFO - Contents: 12:33:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/645118950a34fed42f3dc10b9d5602555f154ddb7ac17beb9ac342d499fb4e21c5e004a0f10aa4a65a85adae14798d41ceb5916fc96c75f92c3ae82d12969b93", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/965fe2fc522fda06e61d7e245ec2328275ab16c51127e9ea03a1ffdfadb975587785c269464cabcff42d49b70b35d7b625ff227a3e042f73a47d1c223e69b108", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/214d061f210e38fa94afaeee89a7391fd3936f6dbbf202c9a9e06cfe46df75d8c0055003dfe10e11c1707bc6664378d978457644fb45dcdfdf41be9267038d27"} 12:33:45 INFO - Running post-run listener: copy_logs_to_upload_dir 12:33:45 INFO - Copying logs to upload dir... 12:33:45 INFO - mkdir: /builds/slave/test/build/upload/logs 12:33:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.802922 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-07-01 12:33:45.648365) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-01 12:33:45.652016) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1467400282.177338-1438599735 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/645118950a34fed42f3dc10b9d5602555f154ddb7ac17beb9ac342d499fb4e21c5e004a0f10aa4a65a85adae14798d41ceb5916fc96c75f92c3ae82d12969b93", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/965fe2fc522fda06e61d7e245ec2328275ab16c51127e9ea03a1ffdfadb975587785c269464cabcff42d49b70b35d7b625ff227a3e042f73a47d1c223e69b108", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/214d061f210e38fa94afaeee89a7391fd3936f6dbbf202c9a9e06cfe46df75d8c0055003dfe10e11c1707bc6664378d978457644fb45dcdfdf41be9267038d27"} build_url:https://queue.taskcluster.net/v1/task/BDYG5pMWQrOZYLexkHRKKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011212 build_url: 'https://queue.taskcluster.net/v1/task/BDYG5pMWQrOZYLexkHRKKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/645118950a34fed42f3dc10b9d5602555f154ddb7ac17beb9ac342d499fb4e21c5e004a0f10aa4a65a85adae14798d41ceb5916fc96c75f92c3ae82d12969b93", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/965fe2fc522fda06e61d7e245ec2328275ab16c51127e9ea03a1ffdfadb975587785c269464cabcff42d49b70b35d7b625ff227a3e042f73a47d1c223e69b108", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/214d061f210e38fa94afaeee89a7391fd3936f6dbbf202c9a9e06cfe46df75d8c0055003dfe10e11c1707bc6664378d978457644fb45dcdfdf41be9267038d27"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-01 12:33:45.677617) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 12:33:45.677957) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1467400282.177338-1438599735 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004493 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 12:33:45.763735) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-01 12:33:45.764131) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-01 12:33:45.764550) ========= ========= Total master_lag: 0.19 =========