builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-055 starttime: 1468429779.17 results: success (0) buildid: 20160713082826 builduid: 76a6f8f5ee9d4a6ba4d4eb2ec1d23e6a revision: 5fc004cf355f0321c2f6de841f84c20822bc2a91 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 10:09:39.173599) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 10:09:39.174157) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 10:09:39.174437) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 10:09:39.192236) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 10:09:39.192759) ========= 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=bb9b54edd4a927dc735d112f000001d9-1468429778.489520-822991847 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-13 10:09:39-- 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% 33.3M=0s 2016-07-13 10:09:39 (33.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.108015 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 10:09:39.315140) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 10:09:39.315482) ========= 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=bb9b54edd4a927dc735d112f000001d9-1468429778.489520-822991847 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017574 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 10:09:39.365564) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 10:09:39.365996) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5fc004cf355f0321c2f6de841f84c20822bc2a91 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 5fc004cf355f0321c2f6de841f84c20822bc2a91 --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=bb9b54edd4a927dc735d112f000001d9-1468429778.489520-822991847 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-13 10:09:39,491 truncating revision to first 12 chars 2016-07-13 10:09:39,491 Setting DEBUG logging. 2016-07-13 10:09:39,491 attempt 1/10 2016-07-13 10:09:39,491 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5fc004cf355f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-13 10:09:39,842 unpacking tar archive at: mozilla-central-5fc004cf355f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.725274 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 10:09:40.105036) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 10:09:40.105411) ========= script_repo_revision: 5fc004cf355f0321c2f6de841f84c20822bc2a91 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 10:09:40.105878) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 10:09:40.106149) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 10:09:40.116070) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-07-13 10:09:40.116485) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=bb9b54edd4a927dc735d112f000001d9-1468429778.489520-822991847 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:09:40 INFO - MultiFileLogger online at 20160713 10:09:40 in /builds/slave/test 10:09:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 10:09:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:09:40 INFO - {'append_to_log': False, 10:09:40 INFO - 'base_work_dir': '/builds/slave/test', 10:09:40 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 10:09:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:09:40 INFO - 'branch': 'Firefox-Non-PGO', 10:09:40 INFO - 'buildbot_json_path': 'buildprops.json', 10:09:40 INFO - 'config_files': ('talos/linux_config.py',), 10:09:40 INFO - 'default_actions': ('clobber', 10:09:40 INFO - 'read-buildbot-config', 10:09:40 INFO - 'download-and-extract', 10:09:40 INFO - 'populate-webroot', 10:09:40 INFO - 'create-virtualenv', 10:09:40 INFO - 'install', 10:09:40 INFO - 'run-tests'), 10:09:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:09:40 INFO - 'download_minidump_stackwalk': True, 10:09:40 INFO - 'download_symbols': 'ondemand', 10:09:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:09:40 INFO - 'tooltool.py': '/tools/tooltool.py', 10:09:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:09:40 INFO - '/tools/misc-python/virtualenv.py')}, 10:09:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:09:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:09:40 INFO - 'installer_path': 'installer.exe', 10:09:40 INFO - 'log_level': 'info', 10:09:40 INFO - 'log_name': 'talos', 10:09:40 INFO - 'log_to_console': True, 10:09:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:09:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:09:40 INFO - 'opt_config_files': (), 10:09:40 INFO - 'pip_index': False, 10:09:40 INFO - 'sps_profile': False, 10:09:40 INFO - 'sps_profile_interval': 0, 10:09:40 INFO - 'suite': 'dromaeojs', 10:09:40 INFO - 'system_bits': '32', 10:09:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:09:40 INFO - 'title': 'talos-linux64-ix-055', 10:09:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:09:40 INFO - 'use_talos_json': True, 10:09:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:09:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:09:40 INFO - 'work_dir': 'build'} 10:09:40 INFO - ##### 10:09:40 INFO - ##### Running clobber step. 10:09:40 INFO - ##### 10:09:40 INFO - Running pre-action listener: _resource_record_pre_action 10:09:40 INFO - Running main action method: clobber 10:09:40 INFO - rmtree: /builds/slave/test/build 10:09:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:09:40 INFO - Running post-action listener: _resource_record_post_action 10:09:40 INFO - ##### 10:09:40 INFO - ##### Finished clobber step (success) 10:09:40 INFO - ##### 10:09:40 INFO - ##### 10:09:40 INFO - ##### Running read-buildbot-config step. 10:09:40 INFO - ##### 10:09:40 INFO - Running pre-action listener: _resource_record_pre_action 10:09:40 INFO - Running main action method: read_buildbot_config 10:09:40 INFO - Using buildbot properties: 10:09:40 INFO - { 10:09:40 INFO - "project": "", 10:09:40 INFO - "product": "firefox", 10:09:40 INFO - "script_repo_revision": "production", 10:09:40 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 10:09:40 INFO - "repository": "", 10:09:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 10:09:40 INFO - "buildid": "20160713082826", 10:09:40 INFO - "pgo_build": "False", 10:09:40 INFO - "basedir": "/builds/slave/test", 10:09:40 INFO - "buildnumber": 146, 10:09:40 INFO - "slavename": "talos-linux64-ix-055", 10:09:40 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:09:40 INFO - "platform": "ubuntu64_hw", 10:09:40 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 10:09:40 INFO - "branch": "mozilla-central", 10:09:40 INFO - "repo_path": "mozilla-central", 10:09:40 INFO - "revision": "5fc004cf355f0321c2f6de841f84c20822bc2a91", 10:09:40 INFO - "stage_platform": "linux64", 10:09:40 INFO - "builduid": "76a6f8f5ee9d4a6ba4d4eb2ec1d23e6a", 10:09:40 INFO - "slavebuilddir": "test" 10:09:40 INFO - } 10:09:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/C4W1PiDHRNeeMSNBHglpkQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 10:09:40 INFO - Running post-action listener: _resource_record_post_action 10:09:40 INFO - ##### 10:09:40 INFO - ##### Finished read-buildbot-config step (success) 10:09:40 INFO - ##### 10:09:40 INFO - ##### 10:09:40 INFO - ##### Running download-and-extract step. 10:09:40 INFO - ##### 10:09:40 INFO - Running pre-action listener: _resource_record_pre_action 10:09:40 INFO - Running main action method: download_and_extract 10:09:40 INFO - mkdir: /builds/slave/test/build/tests 10:09:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:40 INFO - https://queue.taskcluster.net/v1/task/C4W1PiDHRNeeMSNBHglpkQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:09:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C4W1PiDHRNeeMSNBHglpkQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:09:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C4W1PiDHRNeeMSNBHglpkQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:09:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C4W1PiDHRNeeMSNBHglpkQ/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 10:09:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C4W1PiDHRNeeMSNBHglpkQ/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 10:09:41 INFO - Downloaded 1361 bytes. 10:09:41 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:09:41 INFO - Using the following test package requirements: 10:09:41 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:09:41 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:09:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:09:41 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:09:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:09:41 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:09:41 INFO - u'jsshell-linux-x86_64.zip'], 10:09:41 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:09:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:09:41 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:09:41 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:09:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:09:41 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:09:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:09:41 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:09:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:09:41 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:09:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:09:41 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:09:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:41 INFO - https://queue.taskcluster.net/v1/task/C4W1PiDHRNeeMSNBHglpkQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:09:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C4W1PiDHRNeeMSNBHglpkQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:09:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C4W1PiDHRNeeMSNBHglpkQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:09:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C4W1PiDHRNeeMSNBHglpkQ/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 10:09:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C4W1PiDHRNeeMSNBHglpkQ/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 10:09:42 INFO - Downloaded 22755343 bytes. 10:09:42 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'] 10:09:42 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 10:09:43 INFO - Return code: 0 10:09:43 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 10:09:43 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')]} 10:09:43 INFO - https://queue.taskcluster.net/v1/task/C4W1PiDHRNeeMSNBHglpkQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:09:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C4W1PiDHRNeeMSNBHglpkQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:09:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C4W1PiDHRNeeMSNBHglpkQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:09:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C4W1PiDHRNeeMSNBHglpkQ/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 10:09:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C4W1PiDHRNeeMSNBHglpkQ/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 10:09:44 INFO - Downloaded 22755343 bytes. 10:09:44 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'] 10:09:44 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 10:09:46 INFO - Return code: 0 10:09:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:46 INFO - https://queue.taskcluster.net/v1/task/C4W1PiDHRNeeMSNBHglpkQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:09:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C4W1PiDHRNeeMSNBHglpkQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:09:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C4W1PiDHRNeeMSNBHglpkQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:09:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C4W1PiDHRNeeMSNBHglpkQ/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 10:09:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C4W1PiDHRNeeMSNBHglpkQ/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 10:09:47 INFO - Downloaded 14403317 bytes. 10:09:47 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'] 10:09:47 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 10:09:47 INFO - Return code: 0 10:09:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:47 INFO - https://queue.taskcluster.net/v1/task/C4W1PiDHRNeeMSNBHglpkQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:09:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C4W1PiDHRNeeMSNBHglpkQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:09:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C4W1PiDHRNeeMSNBHglpkQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:09:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C4W1PiDHRNeeMSNBHglpkQ/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 10:09:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C4W1PiDHRNeeMSNBHglpkQ/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 10:09:48 INFO - Downloaded 57051941 bytes. 10:09:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/C4W1PiDHRNeeMSNBHglpkQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:09:48 INFO - mkdir: /builds/slave/test/properties 10:09:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:09:48 INFO - Writing to file /builds/slave/test/properties/build_url 10:09:48 INFO - Contents: 10:09:48 INFO - build_url:https://queue.taskcluster.net/v1/task/C4W1PiDHRNeeMSNBHglpkQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:09:49 INFO - Running post-action listener: _resource_record_post_action 10:09:49 INFO - Running post-action listener: set_extra_try_arguments 10:09:49 INFO - ##### 10:09:49 INFO - ##### Finished download-and-extract step (success) 10:09:49 INFO - ##### 10:09:49 INFO - ##### 10:09:49 INFO - ##### Running populate-webroot step. 10:09:49 INFO - ##### 10:09:49 INFO - Running pre-action listener: _resource_record_pre_action 10:09:49 INFO - Running main action method: populate_webroot 10:09:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:09:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:09:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:09:49 INFO - '--tppagecycles', 10:09:49 INFO - '7'], 10:09:49 INFO - 'tests': ['tsvgm']}}, 10:09:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:09:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:09:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:09:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:09:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:09:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:09:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:09:49 INFO - 'talos_options': ['--disable-e10s'], 10:09:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:09:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:09:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:09:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:09:49 INFO - 'talos_options': ['--disable-e10s'], 10:09:49 INFO - 'tests': ['damp', 'tps']}, 10:09:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:09:49 INFO - 'tests': ['damp', 'tps']}, 10:09:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:09:49 INFO - 'tests': ['dromaeo_dom']}, 10:09:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:09:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:09:49 INFO - 'tests': ['basic_compositor_video']}, 10:09:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:09:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:09:49 INFO - 'tests': ['a11yr', 10:09:49 INFO - 'ts_paint', 10:09:49 INFO - 'tpaint', 10:09:49 INFO - 'sessionrestore', 10:09:49 INFO - 'sessionrestore_no_auto_restore', 10:09:49 INFO - 'tabpaint']}, 10:09:49 INFO - 'other-e10s': {'tests': ['a11yr', 10:09:49 INFO - 'ts_paint', 10:09:49 INFO - 'tpaint', 10:09:49 INFO - 'sessionrestore', 10:09:49 INFO - 'sessionrestore_no_auto_restore', 10:09:49 INFO - 'tabpaint']}, 10:09:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:09:49 INFO - 'ts_paint', 10:09:49 INFO - 'tpaint', 10:09:49 INFO - 'sessionrestore', 10:09:49 INFO - 'sessionrestore_no_auto_restore', 10:09:49 INFO - 'tabpaint']}, 10:09:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:09:49 INFO - 'ts_paint', 10:09:49 INFO - 'tpaint', 10:09:49 INFO - 'sessionrestore', 10:09:49 INFO - 'sessionrestore_no_auto_restore', 10:09:49 INFO - 'tabpaint']}, 10:09:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:09:49 INFO - 'tests': ['a11yr', 10:09:49 INFO - 'ts_paint', 10:09:49 INFO - 'tpaint', 10:09:49 INFO - 'sessionrestore', 10:09:49 INFO - 'sessionrestore_no_auto_restore', 10:09:49 INFO - 'tabpaint']}, 10:09:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:09:49 INFO - 'tests': ['a11yr', 10:09:49 INFO - 'ts_paint', 10:09:49 INFO - 'tpaint', 10:09:49 INFO - 'sessionrestore', 10:09:49 INFO - 'sessionrestore_no_auto_restore', 10:09:49 INFO - 'tabpaint']}, 10:09:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:09:49 INFO - 'tests': ['tsvgx', 10:09:49 INFO - 'tsvgr_opacity', 10:09:49 INFO - 'tart', 10:09:49 INFO - 'tscrollx', 10:09:49 INFO - 'cart']}, 10:09:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:09:49 INFO - 'tsvgr_opacity', 10:09:49 INFO - 'tart', 10:09:49 INFO - 'tscrollx', 10:09:49 INFO - 'cart']}, 10:09:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:09:49 INFO - 'talos_options': ['--disable-e10s'], 10:09:49 INFO - 'tests': ['tp5o']}, 10:09:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:09:49 INFO - 'tests': ['tp5o']}, 10:09:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:09:49 INFO - 'talos_options': ['--disable-e10s', 10:09:49 INFO - '--xperf_path', 10:09:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:09:49 INFO - 'tests': ['tp5n']}, 10:09:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:09:49 INFO - 'talos_options': ['--xperf_path', 10:09:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:09:49 INFO - 'tests': ['tp5n']}}, 10:09:49 INFO - 'talos.zip': {'path': '', 10:09:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:09:49 INFO - Running post-action listener: _resource_record_post_action 10:09:49 INFO - ##### 10:09:49 INFO - ##### Finished populate-webroot step (success) 10:09:49 INFO - ##### 10:09:49 INFO - ##### 10:09:49 INFO - ##### Running create-virtualenv step. 10:09:49 INFO - ##### 10:09:49 INFO - Running pre-action listener: _resource_record_pre_action 10:09:49 INFO - Running main action method: create_virtualenv 10:09:49 INFO - Creating virtualenv /builds/slave/test/build/venv 10:09:49 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 10:09:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:09:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:09:49 INFO - Using real prefix '/usr' 10:09:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:09:50 INFO - Installing distribute.............................................................................................................................................................................................done. 10:09:52 INFO - Installing pip.................done. 10:09:52 INFO - Return code: 0 10:09:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:09:52 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')]} 10:09:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:52 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')]} 10:09:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:52 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 0x184d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b0e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0c3b0>, '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 0x1b0d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0d740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1468429778.489520-822991847', '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 10:09:52 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 10:09:52 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 10:09:52 INFO - Using env: {'DISPLAY': ':0', 10:09:52 INFO - 'HOME': '/home/cltbld', 10:09:52 INFO - 'LANG': 'en_US.UTF-8', 10:09:52 INFO - 'LANGUAGE': 'en_US:en', 10:09:52 INFO - 'LOGNAME': 'cltbld', 10:09:52 INFO - 'MAIL': '/var/mail/cltbld', 10:09:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:52 INFO - 'MOZ_NO_REMOTE': '1', 10:09:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:52 INFO - 'NO_EM_RESTART': '1', 10:09:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:52 INFO - 'PWD': '/builds/slave/test', 10:09:52 INFO - 'SHELL': '/bin/bash', 10:09:52 INFO - 'SHLVL': '1', 10:09:52 INFO - 'TERM': 'linux', 10:09:52 INFO - 'TMOUT': '86400', 10:09:52 INFO - 'USER': 'cltbld', 10:09:52 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1468429778.489520-822991847', 10:09:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:52 INFO - '_': '/tools/buildbot/bin/python'} 10:09:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:52 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 10:09:52 INFO - Cleaning up... 10:09:52 INFO - Return code: 0 10:09:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:09:52 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')]} 10:09:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:52 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')]} 10:09:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:52 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 0x184d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b0e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0c3b0>, '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 0x1b0d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0d740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1468429778.489520-822991847', '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 10:09:52 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 10:09:52 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 10:09:52 INFO - Using env: {'DISPLAY': ':0', 10:09:52 INFO - 'HOME': '/home/cltbld', 10:09:52 INFO - 'LANG': 'en_US.UTF-8', 10:09:52 INFO - 'LANGUAGE': 'en_US:en', 10:09:52 INFO - 'LOGNAME': 'cltbld', 10:09:52 INFO - 'MAIL': '/var/mail/cltbld', 10:09:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:52 INFO - 'MOZ_NO_REMOTE': '1', 10:09:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:52 INFO - 'NO_EM_RESTART': '1', 10:09:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:52 INFO - 'PWD': '/builds/slave/test', 10:09:52 INFO - 'SHELL': '/bin/bash', 10:09:52 INFO - 'SHLVL': '1', 10:09:52 INFO - 'TERM': 'linux', 10:09:52 INFO - 'TMOUT': '86400', 10:09:52 INFO - 'USER': 'cltbld', 10:09:52 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1468429778.489520-822991847', 10:09:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:52 INFO - '_': '/tools/buildbot/bin/python'} 10:09:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:52 INFO - Downloading/unpacking psutil>=3.1.1 10:09:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:09:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:09:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:09:54 INFO - Installing collected packages: psutil 10:09:54 INFO - Running setup.py install for psutil 10:09:54 INFO - building 'psutil._psutil_linux' extension 10:09:54 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 10:09:54 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 10:09:54 INFO - building 'psutil._psutil_posix' extension 10:09:54 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 10:09:55 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 10:09:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:09:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:09:55 INFO - Successfully installed psutil 10:09:55 INFO - Cleaning up... 10:09:55 INFO - Return code: 0 10:09:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:09: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')]} 10:09:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09: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')]} 10:09:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:55 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 0x184d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b0e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0c3b0>, '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 0x1b0d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0d740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1468429778.489520-822991847', '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 10:09:55 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 10:09:55 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 10:09:55 INFO - Using env: {'DISPLAY': ':0', 10:09:55 INFO - 'HOME': '/home/cltbld', 10:09:55 INFO - 'LANG': 'en_US.UTF-8', 10:09:55 INFO - 'LANGUAGE': 'en_US:en', 10:09:55 INFO - 'LOGNAME': 'cltbld', 10:09:55 INFO - 'MAIL': '/var/mail/cltbld', 10:09:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:55 INFO - 'MOZ_NO_REMOTE': '1', 10:09:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:55 INFO - 'NO_EM_RESTART': '1', 10:09:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:55 INFO - 'PWD': '/builds/slave/test', 10:09:55 INFO - 'SHELL': '/bin/bash', 10:09:55 INFO - 'SHLVL': '1', 10:09:55 INFO - 'TERM': 'linux', 10:09:55 INFO - 'TMOUT': '86400', 10:09:55 INFO - 'USER': 'cltbld', 10:09:55 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1468429778.489520-822991847', 10:09:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:55 INFO - '_': '/tools/buildbot/bin/python'} 10:09:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:09:55 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 10:09:55 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 10:09:55 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 10:09:55 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 10:09:55 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 10:09:55 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 10:09:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:09:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:09:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:09:57 INFO - Installing collected packages: mozsystemmonitor 10:09:57 INFO - Running setup.py install for mozsystemmonitor 10:09:57 INFO - Successfully installed mozsystemmonitor 10:09:57 INFO - Cleaning up... 10:09:57 INFO - Return code: 0 10:09:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:09:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:57 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 0x184d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b0e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0c3b0>, '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 0x1b0d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0d740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1468429778.489520-822991847', '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 10:09:57 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 10:09:57 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 10:09:57 INFO - Using env: {'DISPLAY': ':0', 10:09:57 INFO - 'HOME': '/home/cltbld', 10:09:57 INFO - 'LANG': 'en_US.UTF-8', 10:09:57 INFO - 'LANGUAGE': 'en_US:en', 10:09:57 INFO - 'LOGNAME': 'cltbld', 10:09:57 INFO - 'MAIL': '/var/mail/cltbld', 10:09:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:57 INFO - 'MOZ_NO_REMOTE': '1', 10:09:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:57 INFO - 'NO_EM_RESTART': '1', 10:09:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:57 INFO - 'PWD': '/builds/slave/test', 10:09:57 INFO - 'SHELL': '/bin/bash', 10:09:57 INFO - 'SHLVL': '1', 10:09:57 INFO - 'TERM': 'linux', 10:09:57 INFO - 'TMOUT': '86400', 10:09:57 INFO - 'USER': 'cltbld', 10:09:57 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1468429778.489520-822991847', 10:09:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:57 INFO - '_': '/tools/buildbot/bin/python'} 10:09:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:57 INFO - Downloading/unpacking jsonschema==2.5.1 10:09:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:09:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:09:59 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 10:09:59 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 10:09:59 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 10:09:59 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 10:09:59 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 10:09:59 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 10:09:59 INFO - Downloading functools32-3.2.3-2.tar.gz 10:09:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:09:59 INFO - warning: no files found matching '*.txt' 10:09:59 INFO - no previously-included directories found matching 'build' 10:09:59 INFO - no previously-included directories found matching 'dist' 10:09:59 INFO - no previously-included directories found matching '.git*' 10:09:59 INFO - Installing collected packages: jsonschema, functools32 10:09:59 INFO - Running setup.py install for functools32 10:09:59 INFO - warning: no files found matching '*.txt' 10:09:59 INFO - no previously-included directories found matching 'build' 10:09:59 INFO - no previously-included directories found matching 'dist' 10:09:59 INFO - no previously-included directories found matching '.git*' 10:10:00 INFO - Successfully installed jsonschema functools32 10:10:00 INFO - Cleaning up... 10:10:00 INFO - Return code: 0 10:10:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:10:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:10:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:10:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x184d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b0e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0c3b0>, '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 0x1b0d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0d740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1468429778.489520-822991847', '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 10:10:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:10:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:10:00 INFO - Using env: {'DISPLAY': ':0', 10:10:00 INFO - 'HOME': '/home/cltbld', 10:10:00 INFO - 'LANG': 'en_US.UTF-8', 10:10:00 INFO - 'LANGUAGE': 'en_US:en', 10:10:00 INFO - 'LOGNAME': 'cltbld', 10:10:00 INFO - 'MAIL': '/var/mail/cltbld', 10:10:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:00 INFO - 'MOZ_NO_REMOTE': '1', 10:10:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:10:00 INFO - 'NO_EM_RESTART': '1', 10:10:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:10:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:00 INFO - 'PWD': '/builds/slave/test', 10:10:00 INFO - 'SHELL': '/bin/bash', 10:10:00 INFO - 'SHLVL': '1', 10:10:00 INFO - 'TERM': 'linux', 10:10:00 INFO - 'TMOUT': '86400', 10:10:00 INFO - 'USER': 'cltbld', 10:10:00 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1468429778.489520-822991847', 10:10:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:00 INFO - '_': '/tools/buildbot/bin/python'} 10:10:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:00 INFO - Downloading/unpacking blobuploader==1.2.4 10:10:00 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 10:10:00 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 10:10:00 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 10:10:00 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 10:10:00 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 10:10:00 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 10:10:02 INFO - Downloading blobuploader-1.2.4.tar.gz 10:10:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:10:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:10:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:10:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:10:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:10:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:10:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:10:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:10:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:10:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:10:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:10:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:10:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:10:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:10:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:10:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:10:02 INFO - Downloading docopt-0.6.1.tar.gz 10:10:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:10:02 INFO - Installing collected packages: blobuploader, requests, docopt 10:10:02 INFO - Running setup.py install for blobuploader 10:10:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:10:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:10:03 INFO - Running setup.py install for requests 10:10:03 INFO - Running setup.py install for docopt 10:10:03 INFO - Successfully installed blobuploader requests docopt 10:10:03 INFO - Cleaning up... 10:10:03 INFO - Return code: 0 10:10:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:10:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:10:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:10:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:03 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 0x184d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b0e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0c3b0>, '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 0x1b0d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0d740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1468429778.489520-822991847', '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 10:10:03 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 10:10:03 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 10:10:03 INFO - Using env: {'DISPLAY': ':0', 10:10:03 INFO - 'HOME': '/home/cltbld', 10:10:03 INFO - 'LANG': 'en_US.UTF-8', 10:10:03 INFO - 'LANGUAGE': 'en_US:en', 10:10:03 INFO - 'LOGNAME': 'cltbld', 10:10:03 INFO - 'MAIL': '/var/mail/cltbld', 10:10:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:03 INFO - 'MOZ_NO_REMOTE': '1', 10:10:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:10:03 INFO - 'NO_EM_RESTART': '1', 10:10:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:10:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:03 INFO - 'PWD': '/builds/slave/test', 10:10:03 INFO - 'SHELL': '/bin/bash', 10:10:03 INFO - 'SHLVL': '1', 10:10:03 INFO - 'TERM': 'linux', 10:10:03 INFO - 'TMOUT': '86400', 10:10:03 INFO - 'USER': 'cltbld', 10:10:03 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1468429778.489520-822991847', 10:10:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:03 INFO - '_': '/tools/buildbot/bin/python'} 10:10:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:10:03 INFO - Running setup.py (path:/tmp/pip-5vY77Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:10:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:10:03 INFO - Running setup.py (path:/tmp/pip-Vxqpl8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:10:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:10:03 INFO - Running setup.py (path:/tmp/pip-DcZMty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:10:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:10:04 INFO - Running setup.py (path:/tmp/pip-QuSBcR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:10:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:10:04 INFO - Running setup.py (path:/tmp/pip-fgn2ed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:10:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:10:04 INFO - Running setup.py (path:/tmp/pip-ycU7VM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:10:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:10:04 INFO - Running setup.py (path:/tmp/pip-fckOHs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:10:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:10:04 INFO - Running setup.py (path:/tmp/pip-sVlFT1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:10:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:10:04 INFO - Running setup.py (path:/tmp/pip-Y1kPLe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:10:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:10:04 INFO - Running setup.py (path:/tmp/pip-wy3Bhe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:10:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:10:04 INFO - Running setup.py (path:/tmp/pip-CRbSSr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:10:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:10:04 INFO - Running setup.py (path:/tmp/pip-6fviKI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:10:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:10:04 INFO - Running setup.py (path:/tmp/pip-7VKGB9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:10:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:10:04 INFO - Running setup.py (path:/tmp/pip-ajGDS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:10:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:10:04 INFO - Running setup.py (path:/tmp/pip-Ron8s4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:10:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:10:04 INFO - Running setup.py (path:/tmp/pip-pqUXCC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:10:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:10:05 INFO - Running setup.py (path:/tmp/pip-4ZFzQI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:10:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:10:05 INFO - Running setup.py install for manifestparser 10:10:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:10:05 INFO - Running setup.py install for mozcrash 10:10:05 INFO - Running setup.py install for mozdebug 10:10:05 INFO - Running setup.py install for mozdevice 10:10:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:10:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:10:05 INFO - Running setup.py install for mozfile 10:10:05 INFO - Running setup.py install for mozhttpd 10:10:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:10:05 INFO - Running setup.py install for mozinfo 10:10:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:10:05 INFO - Running setup.py install for mozInstall 10:10:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:10:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:10:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:10:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:10:05 INFO - Running setup.py install for mozleak 10:10:05 INFO - Running setup.py install for mozlog 10:10:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:10:06 INFO - Running setup.py install for moznetwork 10:10:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:10:06 INFO - Running setup.py install for mozprocess 10:10:06 INFO - Running setup.py install for mozprofile 10:10:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:10:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:10:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:10:06 INFO - Running setup.py install for mozrunner 10:10:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:10:06 INFO - Running setup.py install for mozscreenshot 10:10:06 INFO - Running setup.py install for moztest 10:10:06 INFO - Running setup.py install for mozversion 10:10:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:10:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:10:06 INFO - Cleaning up... 10:10:06 INFO - Return code: 0 10:10:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:10:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:10:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:10:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:06 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 0x184d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b0e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0c3b0>, '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 0x1b0d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0d740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1468429778.489520-822991847', '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 10:10:06 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 10:10:06 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 10:10:06 INFO - Using env: {'DISPLAY': ':0', 10:10:06 INFO - 'HOME': '/home/cltbld', 10:10:06 INFO - 'LANG': 'en_US.UTF-8', 10:10:06 INFO - 'LANGUAGE': 'en_US:en', 10:10:06 INFO - 'LOGNAME': 'cltbld', 10:10:06 INFO - 'MAIL': '/var/mail/cltbld', 10:10:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:06 INFO - 'MOZ_NO_REMOTE': '1', 10:10:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:10:06 INFO - 'NO_EM_RESTART': '1', 10:10:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:10:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:06 INFO - 'PWD': '/builds/slave/test', 10:10:06 INFO - 'SHELL': '/bin/bash', 10:10:06 INFO - 'SHLVL': '1', 10:10:06 INFO - 'TERM': 'linux', 10:10:06 INFO - 'TMOUT': '86400', 10:10:06 INFO - 'USER': 'cltbld', 10:10:06 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1468429778.489520-822991847', 10:10:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:06 INFO - '_': '/tools/buildbot/bin/python'} 10:10:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:10:07 INFO - Running setup.py (path:/tmp/pip-LRAdD0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:10:07 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)) 10:10:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:10:07 INFO - Running setup.py (path:/tmp/pip-Ukxgs_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:10:07 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)) 10:10:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:10:07 INFO - Running setup.py (path:/tmp/pip-uoyvQO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:10:07 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)) 10:10:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:10:07 INFO - Running setup.py (path:/tmp/pip-Po6bX4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:10:07 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)) 10:10:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:10:07 INFO - Running setup.py (path:/tmp/pip-GdqFQM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:10:07 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)) 10:10:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:10:07 INFO - Running setup.py (path:/tmp/pip-VxS6Xh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:10:07 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)) 10:10:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:10:07 INFO - Running setup.py (path:/tmp/pip-aljsSX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:10:07 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)) 10:10:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:10:07 INFO - Running setup.py (path:/tmp/pip-8lYHHx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:10:07 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)) 10:10:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:10:07 INFO - Running setup.py (path:/tmp/pip-mSP1VJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:10:07 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)) 10:10:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:10:07 INFO - Running setup.py (path:/tmp/pip-SXzlt8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:10:07 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)) 10:10:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:10:07 INFO - Running setup.py (path:/tmp/pip-dKrmKy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:10:07 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)) 10:10:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:10:07 INFO - Running setup.py (path:/tmp/pip-iYudTH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:10:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:10:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:10:07 INFO - Running setup.py (path:/tmp/pip-eZ_HDh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:10:08 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)) 10:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:10:08 INFO - Running setup.py (path:/tmp/pip-RlUuuY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:10:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:10:08 INFO - Running setup.py (path:/tmp/pip-tGMfiv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:10:08 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)) 10:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:10:08 INFO - Running setup.py (path:/tmp/pip-76cAn1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:10:08 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)) 10:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:10:08 INFO - Running setup.py (path:/tmp/pip-AmQjv5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:10:08 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)) 10:10:08 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)) 10:10:08 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)) 10:10:08 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)) 10:10:08 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)) 10:10:08 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)) 10:10:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:10:08 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 10:10:08 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 10:10:08 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 10:10:08 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 10:10:08 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 10:10:08 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 10:10:10 INFO - Downloading blessings-1.6.tar.gz 10:10:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:10:10 INFO - Installing collected packages: blessings 10:10:10 INFO - Running setup.py install for blessings 10:10:10 INFO - Successfully installed blessings 10:10:10 INFO - Cleaning up... 10:10:10 INFO - Return code: 0 10:10:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:10:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:10:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:10:10 INFO - Reading from file tmpfile_stdout 10:10:10 INFO - Current package versions: 10:10:10 INFO - argparse == 1.2.1 10:10:10 INFO - blessings == 1.6 10:10:10 INFO - blobuploader == 1.2.4 10:10:10 INFO - docopt == 0.6.1 10:10:10 INFO - functools32 == 3.2.3-2 10:10:10 INFO - jsonschema == 2.5.1 10:10:10 INFO - manifestparser == 1.1 10:10:10 INFO - mozInstall == 1.12 10:10:10 INFO - mozcrash == 0.17 10:10:10 INFO - mozdebug == 0.1 10:10:10 INFO - mozdevice == 0.48 10:10:10 INFO - mozfile == 1.2 10:10:10 INFO - mozhttpd == 0.7 10:10:10 INFO - mozinfo == 0.9 10:10:10 INFO - mozleak == 0.1 10:10:10 INFO - mozlog == 3.2 10:10:10 INFO - moznetwork == 0.27 10:10:10 INFO - mozprocess == 0.23 10:10:10 INFO - mozprofile == 0.28 10:10:10 INFO - mozrunner == 6.12 10:10:10 INFO - mozscreenshot == 0.1 10:10:10 INFO - mozsystemmonitor == 0.3 10:10:10 INFO - moztest == 0.7 10:10:10 INFO - mozversion == 1.4 10:10:10 INFO - psutil == 3.1.1 10:10:10 INFO - requests == 1.2.3 10:10:10 INFO - wsgiref == 0.1.2 10:10:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:10:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:10:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:10:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:10 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 0x184d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b0e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0c3b0>, '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 0x1b0d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0d740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1468429778.489520-822991847', '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 10:10:10 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 10:10:10 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 10:10:10 INFO - Using env: {'DISPLAY': ':0', 10:10:10 INFO - 'HOME': '/home/cltbld', 10:10:10 INFO - 'LANG': 'en_US.UTF-8', 10:10:10 INFO - 'LANGUAGE': 'en_US:en', 10:10:10 INFO - 'LOGNAME': 'cltbld', 10:10:10 INFO - 'MAIL': '/var/mail/cltbld', 10:10:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:10 INFO - 'MOZ_NO_REMOTE': '1', 10:10:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:10:10 INFO - 'NO_EM_RESTART': '1', 10:10:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:10:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:10 INFO - 'PWD': '/builds/slave/test', 10:10:10 INFO - 'SHELL': '/bin/bash', 10:10:10 INFO - 'SHLVL': '1', 10:10:10 INFO - 'TERM': 'linux', 10:10:10 INFO - 'TMOUT': '86400', 10:10:10 INFO - 'USER': 'cltbld', 10:10:10 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1468429778.489520-822991847', 10:10:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:10 INFO - '_': '/tools/buildbot/bin/python'} 10:10:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:11 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)) 10:10:11 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)) 10:10:11 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)) 10:10:11 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)) 10:10:11 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)) 10:10:11 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)) 10:10:11 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)) 10:10:11 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)) 10:10:11 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)) 10:10:11 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)) 10:10:11 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)) 10:10:11 INFO - Cleaning up... 10:10:11 INFO - Return code: 0 10:10:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:10:11 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')]} 10:10:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:11 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')]} 10:10:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:11 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 0x184d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b0e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0c3b0>, '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 0x1b0d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0d740>, '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': 'bb9b54edd4a927dc735d112f000001d9-1468429778.489520-822991847', '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 10:10:11 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 10:10:11 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 10:10:11 INFO - Using env: {'DISPLAY': ':0', 10:10:11 INFO - 'HOME': '/home/cltbld', 10:10:11 INFO - 'LANG': 'en_US.UTF-8', 10:10:11 INFO - 'LANGUAGE': 'en_US:en', 10:10:11 INFO - 'LOGNAME': 'cltbld', 10:10:11 INFO - 'MAIL': '/var/mail/cltbld', 10:10:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:11 INFO - 'MOZ_NO_REMOTE': '1', 10:10:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:10:11 INFO - 'NO_EM_RESTART': '1', 10:10:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:10:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:11 INFO - 'PWD': '/builds/slave/test', 10:10:11 INFO - 'SHELL': '/bin/bash', 10:10:11 INFO - 'SHLVL': '1', 10:10:11 INFO - 'TERM': 'linux', 10:10:11 INFO - 'TMOUT': '86400', 10:10:11 INFO - 'USER': 'cltbld', 10:10:11 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1468429778.489520-822991847', 10:10:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:11 INFO - '_': '/tools/buildbot/bin/python'} 10:10:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:10:11 INFO - Cleaning up... 10:10:11 INFO - Return code: 0 10:10:11 INFO - Running post-action listener: _resource_record_post_action 10:10:11 INFO - Running post-action listener: _start_resource_monitoring 10:10:11 INFO - Starting resource monitoring. 10:10:11 INFO - ##### 10:10:11 INFO - ##### Finished create-virtualenv step (success) 10:10:11 INFO - ##### 10:10:11 INFO - ##### 10:10:11 INFO - ##### Running install step. 10:10:11 INFO - ##### 10:10:11 INFO - Running pre-action listener: _resource_record_pre_action 10:10:11 INFO - Running main action method: install 10:10:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:10:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:10:11 INFO - Reading from file tmpfile_stdout 10:10:11 INFO - Detecting whether we're running mozinstall >=1.0... 10:10:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:10:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:10:11 INFO - Reading from file tmpfile_stdout 10:10:11 INFO - Output received: 10:10:11 INFO - Usage: mozinstall [options] installer 10:10:11 INFO - Options: 10:10:11 INFO - -h, --help show this help message and exit 10:10:11 INFO - -d DEST, --destination=DEST 10:10:11 INFO - Directory to install application into. [default: 10:10:11 INFO - "/builds/slave/test"] 10:10:11 INFO - --app=APP Application being installed. [default: firefox] 10:10:11 INFO - mkdir: /builds/slave/test/build/application 10:10:11 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'] 10:10:11 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 10:10:28 INFO - Reading from file tmpfile_stdout 10:10:28 INFO - Output received: 10:10:28 INFO - /builds/slave/test/build/application/firefox/firefox 10:10:28 INFO - Running post-action listener: _resource_record_post_action 10:10:28 INFO - ##### 10:10:28 INFO - ##### Finished install step (success) 10:10:28 INFO - ##### 10:10:28 INFO - ##### 10:10:28 INFO - ##### Running run-tests step. 10:10:28 INFO - ##### 10:10:28 INFO - Running pre-action listener: _resource_record_pre_action 10:10:28 INFO - Running main action method: run_tests 10:10:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:10:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:10:28 INFO - Python 2.7.3 10:10:28 INFO - Return code: 0 10:10:28 INFO - grabbing minidump binary from tooltool 10:10:28 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')]} 10:10:28 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 0x1b0c3b0>, '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 0x1b0d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0d740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:10:28 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 10:10:28 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 10:10:28 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 10:10:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:10:28 INFO - Return code: 0 10:10:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:10:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:10:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:10:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:10:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:10:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/C4W1PiDHRNeeMSNBHglpkQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 10:10:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/C4W1PiDHRNeeMSNBHglpkQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --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 10:10:28 INFO - Using env: {'DISPLAY': ':0', 10:10:28 INFO - 'HOME': '/home/cltbld', 10:10:28 INFO - 'LANG': 'en_US.UTF-8', 10:10:28 INFO - 'LANGUAGE': 'en_US:en', 10:10:28 INFO - 'LOGNAME': 'cltbld', 10:10:28 INFO - 'MAIL': '/var/mail/cltbld', 10:10:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:10:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:10:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:28 INFO - 'MOZ_NO_REMOTE': '1', 10:10:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:10:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:10:28 INFO - 'NO_EM_RESTART': '1', 10:10:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:10:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:28 INFO - 'PWD': '/builds/slave/test', 10:10:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:10:28 INFO - 'SHELL': '/bin/bash', 10:10:28 INFO - 'SHLVL': '1', 10:10:28 INFO - 'TERM': 'linux', 10:10:28 INFO - 'TMOUT': '86400', 10:10:28 INFO - 'USER': 'cltbld', 10:10:28 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1468429778.489520-822991847', 10:10:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:28 INFO - '_': '/tools/buildbot/bin/python'} 10:10:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/C4W1PiDHRNeeMSNBHglpkQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 10:10:28 INFO - mozversion application_buildid: 20160713082826 10:10:28 INFO - mozversion application_changeset: 5fc004cf355f0321c2f6de841f84c20822bc2a91 10:10:28 INFO - mozversion application_display_name: Nightly 10:10:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:10:28 INFO - mozversion application_name: Firefox 10:10:28 INFO - mozversion application_remotingname: firefox 10:10:28 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:10:28 INFO - mozversion application_vendor: Mozilla 10:10:28 INFO - mozversion application_version: 50.0a1 10:10:28 INFO - mozversion platform_buildid: 20160713082826 10:10:28 INFO - mozversion platform_changeset: 5fc004cf355f0321c2f6de841f84c20822bc2a91 10:10:28 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:10:28 INFO - mozversion platform_version: 50.0a1 10:10:28 INFO - using testdate: 1468429828 10:10:28 INFO - actual date: 1468429828 10:10:28 INFO - starting webserver on 'localhost:34499' 10:10:28 INFO - SUITE-START | Running 2 tests 10:10:28 INFO - TEST-START | dromaeo_css 10:10:28 INFO - operating with platform_type : linux_ 10:10:28 INFO - Initialising browser for dromaeo_css test... 10:10:28 INFO - TEST-INFO | started process 28632 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOdZ17l/profile http://localhost:34499/getInfo.html) 10:10:32 INFO - PROCESS | 28632 | __metrics Screen width/height:1600/1200 10:10:32 INFO - PROCESS | 28632 | colorDepth:24 10:10:32 INFO - PROCESS | 28632 | Browser inner width/height: 1024/697 10:10:32 INFO - PROCESS | 28632 | __metrics 10:10:33 INFO - PROCESS | 28632 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:10:33 INFO - PROCESS | 28632 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:10:34 INFO - TEST-INFO | 28632: exit 0 10:10:34 INFO - Browser initialized. 10:10:34 INFO - Running cycle 1/1 for dromaeo_css test... 10:10:34 INFO - TEST-INFO | started process 28713 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOdZ17l/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:10:46 INFO - PROCESS | 28713 | RSS: Main: 159195136 10:10:46 INFO - PROCESS | 28713 | 10:11:37 INFO - PROCESS | 28713 | 1468429897053 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] 10:13:49 INFO - PROCESS | 28713 | Cycle 1(1): loaded http://localhost:34499/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34499/tests/dromaeo/cssquery-ext.html) 10:13:50 INFO - PROCESS | 28713 | RSS: Main: 238858240 10:13:50 INFO - PROCESS | 28713 | 10:16:53 INFO - PROCESS | 28713 | Cycle 1(1): loaded http://localhost:34499/tests/dromaeo/cssquery-ext.html (next: http://localhost:34499/tests/dromaeo/cssquery-jquery.html) 10:16:53 INFO - PROCESS | 28713 | RSS: Main: 237338624 10:16:53 INFO - PROCESS | 28713 | 10:19:56 INFO - PROCESS | 28713 | Cycle 1(1): loaded http://localhost:34499/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34499/tests/dromaeo/cssquery-mootools.html) 10:19:56 INFO - PROCESS | 28713 | RSS: Main: 235675648 10:19:56 INFO - PROCESS | 28713 | 10:22:59 INFO - PROCESS | 28713 | Cycle 1(1): loaded http://localhost:34499/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34499/tests/dromaeo/cssquery-prototype.html) 10:22:59 INFO - PROCESS | 28713 | RSS: Main: 241709056 10:22:59 INFO - PROCESS | 28713 | 10:26:02 INFO - PROCESS | 28713 | Cycle 1(1): loaded http://localhost:34499/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34499/tests/dromaeo/cssquery-yui.html) 10:26:03 INFO - PROCESS | 28713 | RSS: Main: 207659008 10:26:03 INFO - PROCESS | 28713 | 10:29:06 INFO - PROCESS | 28713 | Cycle 1(1): loaded http://localhost:34499/tests/dromaeo/cssquery-yui.html (next: http://localhost:34499/tests/dromaeo/cssquery-dojo.html) 10:29:06 INFO - PROCESS | 28713 | RSS: Main: 275996672 10:29:06 INFO - PROCESS | 28713 | 10:29:06 INFO - PROCESS | 28713 | __start_tp_report 10:29:06 INFO - PROCESS | 28713 | _x_x_mozilla_page_load 10:29:06 INFO - PROCESS | 28713 | _x_x_mozilla_page_load_details 10:29:06 INFO - PROCESS | 28713 | |i|pagename|runs| 10:29:06 INFO - PROCESS | 28713 | |0;dojo.html;2574.9098781542643;2584.2247325802255;2609.556375416179;2626.3302857771264;2627.802914781391;4437;4533.365328853963;4543.341215523747;4578.839740609079;4599.379083823683;4589.265717485203;4617.984043510422;4626.282926146444;4664.463586687532;4668.696534725249;4069.165821006701;4214.1993021325925;4308.806103725325;4331.220380331539;4394.934075988863;4297.290946993742;4367.1265746850595;4369.388285640013;4379.846705365313;4409.316555933835;4094.508658960914;4133.937990930139;4144.046869220097;4197.97901010496;4203.7687927164;4219.219444402765;4220.029393239542;4235.343521754133;4271.081717430768;4283.87148385549;4254.893627659302;4270;4275.551067137968;4303.031817840961;4317.69776115672;4402.3176407656865;4486.55134486552;4570.245909424941;4575.496695363508;4612.469565999886;4872.6832755870755;4898.289747986558;4936.234883593013;4940.950590494085;4944.7527623619035;4808.134535783557;4891.633127515451;4915.361003069614;4955.900881982377;4959;4577.06170235101;4628.884277893012;4632.513586073481;4642.605378542862;4643.094596553708;5072.188449848007;5105.693658380509;5129.8717532061255;5134.409542902539;5144.6655967362;4696.03731235096;4800.807967681254;4917.582005529499;4922.310876477296;4928.901421971541;4964.652474326763;4995.525425084611;4998.375203099613;5014.89970200594;5016.172331565251;4904.190808516555;4916.360873086476;4918.311436398907;4919.581835544019;4976.0794253063295;4684.531546845288;4740.170470167707;4790.736509491941;4900.803967841246;4912.484189160158;4049.4128351388886;4049.7772622506045;4064.8577299794365;4096.795160241976;4105.7331273467125;3606.3328284267495;3611.6207798180812;3614;3630.0743310455664;3655.415133578668;4092.6725861930972;4136.172765446922;4256.29771087767;4267.8079486423185;4290.163418133497;4936.876578085505;4989.850304490871;4991.376077990251;4992.450830408652;5041.470645582234;4322.805473753689;4324.481062272547;4329.220740266782;4361.520232774392;4369.191699535532;4208.873733787991;4346.695731298842;4401.625861801719;4404.0971600822395;4415.448068991376;4714.198586240279;4738.052389522179;4738.218193997952;4739.004808990082;4783.760811959319;5005.174146265971;5006.048850718352;5015.64890457679;5019.899602008012;5065.772040258271;4497.280435130363;4670.439547254351;4711.104890070876;4716.363290955677;4731.739754313546;4881.463039065771;4906.288588154769;4907.141250281115;4911.9754401227765;4967.503249675004;4773.331733557236;4972.925406118983;4987.102321582005;4995.850124496271;5031.471695471922;4742.430908291027;4760.404949381327;4787.952120478751;4790.640701947298;4793.640476964311;4757.928631070467;4785.042991401664;4786.832460863853;4792.305115758265;4840.636952228527;4566.178087944069;4683.992941517454;4713.599344055794;4761.214399624023;4764.571188593043;4820.9517904820505;4838.080764654705;4858.951410485991;4860.343853579721;4910.631702622246;4749.596284315872;4750.833720819893;4753.073150735573;4753.1444340019125;4800 10:29:06 INFO - PROCESS | 28713 | |1;ext.html;563.5716855190054;578.7800635758416;581.9185314056033;584.7456356484929;592.6562593695656;28778.56832147517;31389.686103138964;31547.842260788722;39052.60947390525;40140.183178018604;40140.59859401405;40868.59131408685;40899.795501022454;40940;41002.58997410025;7700.075990881102;7845.64694588742;7853.450258481908;7859.528428294292;7859.68561257549;7841.725539606115;7924.445288829785;7930.484518506308;7931.682732690685;7932.444728868982;7891.368690504746;7914.920850791505;7923.9207607924045;7929.563873986928;7938.722144724936;7876.960615196916;7903.723369682033;7910.9604451977375;7919.960400197991;7922.564258965755;7643.808904777369;7714.845703085963;7720.652570634335;7724.150343462215;7726.575038372887;37598.624013759785;37964.81017594922;38014.42978355327;38017.42973855395;38022.619773802464;2763.7236276372405;2781.6662000560063;2836.5745138229227;2857.8571071446554;2903.651561812575;29413.41173176546;29533.556996645068;29758.70241297581;29957;30011.749118816177;2667.493176296517;2679.954817621129;2703.6620422447195;2758.1863350311705;2786.637737094165;183861.080694597;183873;184706;184957;185177;31632.367352653277;32585.837070814967;51290.74354628278;51657;51687.48312516902;33936.83031584826;33976.49035264473;34036.31927361439;34112.14719631979;34112.48831267533;13301.600951971457;13406.195628262336;13412.39644215993;13416.463341466231;13420.798688019688;10431.330987042189;10434.37393756377;10437.112845408225;10454.268201225841;10457.42484163363;7839.294463498199;7873.724419645285;7880.330171935335;7932.325752311002;7939.761807145795;3101.17818778024;3122.4223518649123;3123;3138.8744450221734;3153.936921261562;794.1740589786557;816.1919699497455;821.1542111625035;843.1020962674854;931.6552875435997;26917.596236056474;27194.728052719616;27507.436049970493;27577.44845103087;27899.721002790116;874.6151693254948;903.2251625555683;930.7859192385654;944.7354740672623;1029.3669393323203;13577.59267221985;13586.660333491742;13594.524191653245;13769.793453098211;13788.517401891086;412610;419166;419368;419586;420118;48024;48652.513474865504;48694;48728.61442470195;48753.5124648749;1052.6684094510206;1173.2139466557428;1175.623800383869;1191.195942738648;1209.9153059285766;27914.44171116607;28454.146375608765;28585;28969.65437366033;29528;40411.1917761649;40569;40690.38964415477;40889.1822163561;41000.79499602483;298279;298302;300305;300349;300383;21717.565648687254;23919.880400597885;24277.63583546213;24580.754192457847;24810.255692329258;41550.376744349465;41845.48927064386;41888.3716744243;42232.788836055624;42769.358459623756;35182.82408587941;35857.64142358543;36118.81940590385;36486.27027459489;36557.634423656484;35452.46821297631;35772;36244.4563331545;36323.63676363203;36429;35137.648623513436;35353.939381818585;35631;36151.09622259464;36258.8187059063;26594;28153.577696334163;28273.57589636198;28322.85838570794;28394.550560957192;24879.626805597567;24921.376965576004;24929.87535062313;25086.247412577653;25093.87453062723 10:29:06 INFO - PROCESS | 28713 | |2;jquery.html;333.64133556426845;364.87411842914196;373.84859132051514;377.7752237418735;395.371359538334;12926.095173337859;16489.257983390748;16673.666526669476;18776.530586735305;18777.061146942633;16597.41909033184;17196.968181909095;17858.46424607264;17913.82086179141;18211.635767284646;4927.531884470978;5001.399832020163;5132.820351287705;5136.486351364871;5139.152039913429;3715.5912849586525;5029.547340739333;5665.291838520185;6053.273607167124;6074.149619053336;6043.724149573738;6095.817125486243;6103.664298463583;6108.908366374508;6136.693165341738;6013.308469525995;6130.417610327012;6140.539459540552;6157.63054216744;6184.28880678721;3420.640832712554;5029.346184995964;5337.092694241988;5351.2240725095035;5396.676199428008;22037;22192;22425.77574224253;22513;22863.54272914549;1723.7931448226168;1775.1301862087614;1816.1464111867401;1847.1964695357563;1948.5226119600648;13212.273324967124;13577.932110339483;13635.454581816715;13978.790318145237;14043.22762248076;1761.1898526677744;2040.7040979058102;2042.6629606114973;2146.3131797824703;2196.967045494319;79673.60163199146;82564;82953;83049.58475207645;84033.15966840314;14166.362513686703;14676.588322896869;16602.766294595043;17184.656306874043;17474.91262543679;29506.852465737535;29548.852255739013;29685.554716679268;29762.702372976426;29856.701432985392;9175.403598766059;9280.164785169367;9282.535873206312;9307.581158847868;9458.57436415363;7666.923330766733;7713.575753333508;7811.414143939227;7833.138354780969;7846.568438735924;8413.873791893126;8594.78513037179;8648.913510864937;8716.564171791386;8920.687775927941;3151.68483151683;3155.763317751132;3161;3299.7002997002996;3323.1512537933413;816.4448175240893;823.8022874510194;903.3134817538718;911.1480765484293;913.2967614936462;16852;17155.313787448613;17726.468205953843;17734.29062837498;17853.28586856511;819.3895547816915;820.2576668115365;833.5790425834914;866.9523176225242;875.9036505984336;9158.001509011609;9854.211663066937;9969.750756231153;10021.599136034623;10169.847452288222;362513;365167;367450;380223;380743;79749.60125199337;79936;80358.19641803508;82541.99999999879;83507.58246208851;806.3750593290247;830.3066939105914;834.9290310323569;836.7447928381902;843.890294261742;12160.574379896661;16322;16351.427700030441;16374.590635234214;16572.66854662924;39139.41290880582;39394.40908386319;39442.211155777295;39565.80217098896;39747;48137.7965550864;48897.266541002624;49445.50554494409;49690.50309496859;50489.24266136084;7333.816654583465;7346.191918888811;7376.446766492427;7490.925090749023;7933.920660793318;9950.303478756417;10961.56153753841;11323;11342.149338799458;11388.430578471209;9421.199198068241;9446.905530944878;9634.229261659191;9698;9707.708768736667;10008.499575021366;10216.846747298945;10307.123894468754;10344.069033786995;10466.424346660702;9658.565364558752;9790.75523111928;10030.64892728751;10454.215933804842;10497.422641754776;6951.930480695129;7023.719051238098;7086.539374940612;7149.034880291094;7259.346658800733;5013.924791128063;6024.698765061642;7930.651789195736;9637.277204209571;10282.742931426475 10:29:06 INFO - PROCESS | 28713 | |3;mootools.html;1368.5004973184787;1420.7939848721935;1498.7601983682614;1646.1604581663348;1698.2018451327879;7650.2732240437135;8101;8190.91809081909;8191.426600137986;8191.959040204791;6596.604203747778;6808.829779255521;7605.543667379961;7843.254890785366;7947.880781788278;2181.454636340911;2203.713517242756;2205.1179528188773;2213.181122984498;2214.081156320125;2197.450637340665;2202.9559408811815;2249.910003599854;2255.221948427798;2255.4135924659627;1822.571695651521;2112.661974084147;2181.1275489804125;2196.3191410662744;2204.9779502205015;2175.2386664667397;2176.216562037665;2187.595294870454;2189.189999700121;2214.2250212425524;2149.57008598281;2151.1717988574355;2153.7415510138726;2158.212252527832;2158.212252527832;8029.799255018613;8085.555294458803;8089.352851771844;8093.473924194908;8096.473729207582;4437.5784300491405;4491.775411229425;4571.291449825282;4573.291139873325;4583.724976501388;2563.0901030134405;2677.3039009857575;2689.932751681204;2692.9192124236306;2714.5520989036786;774.4501404003164;794.8926894869235;804.569555287924;809.7530253272749;817.4155478832604;10574.894251057467;10696.411697356642;10717.303375280582;10724.14206863449;10794.622188223375;3934.9803250983564;4048.777317247521;4127.360259159835;4136.875893723193;4259.701820872509;9168.495732734764;9175.724728258163;9177.816443671089;9185;9243.445393276425;4671.11248862715;4677.017826256524;4686.062787442525;4698.201305778026;4705.764711764398;4164.937525937114;4217.810198541011;4237.745735255895;4241.448611680524;4249.702520823575;3702.6667599916136;3722.3299806034634;3751.099736063325;3827.8086095695103;3835.76985380878;1073.4042606353548;1171.221137943258;1184.461070213051;1204.2292932523192;1207.8007128823822;668.5873236638149;728.1553398058227;835.1815221083373;836.3560058754846;856.8886044814134;5480.890382192413;5492.286002819608;5509.917351239735;5525.143602741581;5721.456461636138;810.8337790752881;843.4280820724229;847.9576021198916;880.9560670605354;897.1477096758106;3471.7049050830456;3587.5336206293014;3587.8385472653795;3592.2815436912724;3630.128769095451;9544;9818.90181098194;10001.599936002478;10006.399616023062;10019.098281154731;8218.424710270343;9186.127317904788;9631.807363852824;9632.807343853083;9906.55420506079;7391.408687305003;7545.434092442979;7560.395168386516;7569.621518924142;7590.924090759022;5445.618806683653;5477.014137455296;5505.862353441196;5719.656820590778;5772.913406298825;8950.373473856767;9184.44893306377;9293;9302.116298951589;9322.021187775457;8945.329100317373;9247.352685311964;9303.441793492411;9320.860187097063;9328.860067098864;6676.966615167087;6783.152105986752;6783.694733736895;6791.422729068085;6793.864122717419;7462.96268518654;7537.510061845963;7542.434317426325;7544.434167437574;7545.358644515058;6730.764423245163;6870.175578930561;6899.20659124187;6960.4779641526075;7041.788746337618;6657.434118100015;6788.456923446014;6812.8978065328065;6864.48516361265;6933.064036355027;6194.287656919512;6219.657918814509;6246.968765156145;6268.811935641938;6310.5267104968225;4367.650587952892;4389.275769497997;4479.776011199492;4497.865064048084;4533.97733011346;4426.690131690751;4432.370460833016;4450.910981780411;4523.11799199153;4560.33875088117 10:29:06 INFO - PROCESS | 28713 | |4;prototype.html;299.2653036794669;300.5131686667599;300.51466880987215;302.833441607116;306.7637918802522;4801.303810947411;4810.134175848346;4837.298591704201;4847.733374664396;4877.195262781637;4741.146593613148;4783.35424717663;4791.185498465261;4820.855374338776;4825.107355139302;3627.6372362763777;3692.3722967095523;3750.699944004487;3795.3547896857463;3823.8279277432443;3794.1273507093383;3796.3735983562815;3809.6761775248997;3813;3826.2921359548573;3618.2220822523154;3780.185510954743;3803.7147213958924;3819.6371344722206;3820.732548721591;3528.4883691864534;3719.1631882826146;3735.2716220337047;3741.3078580462566;3809.7904615246152;3358.630550639428;3362.7477939154414;3363.1423986883187;3370.2248482848836;3381.695647391722;4707.176244157293;4726.385569875894;4735.692180008288;4739.123262196505;4764.142454358214;4246.0680390422285;4316.48202215733;4326.480822301344;4358.171947330029;4364.934525982113;4921.581665558432;4978.950210497885;4979.377577802775;4987.276844857512;5013.6490445668815;3660;3666.1934374437583;3673.3020726061964;3679.521662183899;3697.371446854041;4977.42759582649;5294.6029047821185;5303.655262407931;5315.309009828737;5315.468453154731;3643.4716966039778;3649.3248748981523;3671.0822294426393;3676.5771936227143;3679.35611268027;3717.70258379329;3718.758280711745;3720.404735242348;3720.8697695580527;3727.2731817295366;4245.893852653647;4254.106637606075;4263.786810659517;4274.6793990450215;4280.122574872144;4790.089882922303;5030.823921162815;5033.282027704999;5042.3444952156715;5049.798008079636;1282.923024618526;1288.9226646401246;1295.546558704446;1295.6631275868342;1295.9222446653232;795.718892582941;820.9737827715355;833.6498670558381;837.3426859914938;838.4885220015785;4232.492100947906;4351.73889566627;4466.553344665573;4469.664775141878;4484.9011992061505;5173.793048278102;5188.870278243074;5198.194279886624;5234.895302093937;5234.947650523446;4437.33439984005;4445.288374091801;4450.020995381011;4452.977735111303;4476.149531588988;2638.802089843231;2738.274357295318;2756;2758.848263345535;2760.682521510012;4891.290762839369;4895.33912921751;4921.704697718148;4945.653804233669;4979.228219625964;5079.949200508022;5225.268462415265;5259.973700131552;5293.735313234323;5348.5186333230195;4908.490429343037;4916.410030796327;4921.729304888194;4940.75296235194;4941.579965702884;5180.9740951295;5183.585313174862;5189.6107791915;5194.4805519447755;5227.320448341691;4901.534354236342;5026.296318515338;5070.73231692077;5116.28372027909;5137;4893.804247830047;4905.411350637946;4920.753962301942;4931.161702510653;4940.6788558743565;3664.596894341567;3671.485991961074;3679.24575462035;3687.0229389211345;3697.22358304759;4960.487051449342;5186.273921650896;5195.19474481456;5222.817201397933;5229.163333866563;5010.774515146754;5014.24786282046;5019.196928491424;5025.170846810235;5035.92446113316;4978.153713868579;4989.575886049726;5001.399832020181;5025.6482046256415;5033.47148549397;4748.4776674566465;4901.705897646153;4904.558589726799;4926;4938.506149385033;4741.881452963704;4822.324874517501;5017.974910125572;5032.572231360376;5063;4943.134951383421;4943.283223932438;4953.603711702983;4956.430010548833;4957.810125569765 10:29:06 INFO - PROCESS | 28713 | |5;yui.html;602.4517688903098;662.8508585568245;665.0722242471755;677.3734295776405;697.9546329488581;13222.07445478817;13274.070815042951;13714.725705485884;14152.646183845396;14154.716905661893;12685.492580296777;12697.61907142785;12811.295378754165;12811.487540498392;12834.80747788784;625.4933503861864;763.1833937686678;780.4263866058457;794.8966634337557;801.995990020052;794.761571528542;794.8370584030259;797.1948332184478;797.2466019611469;797.3740613618311;828.9917100828975;832.8958880139983;834.3783881008627;835.0188528479013;835.8955130608674;652.8726898254843;794.2454668065332;821.1542111625035;823.5017814222429;826.3224156191925;605.6971514242879;606.3512042114938;606.9514438844882;607.159084667734;607.2075940897128;13328.333583320893;13334;13365.064445488819;13385.598432046956;13392.665183370495;12790.552330668383;13192.86807131926;13240.801387979189;13268.071235013553;13518.59444216675;11323.094152467866;11564.884351156465;11604.941975290154;11912.940435297767;12034.037277017818;4028.738132021409;4058.898527536806;4151.7924103794685;4195.286801243796;4268.061026574149;59680.40319596792;59866;59904;61377;61702.38297617011;10181.134603558632;10396.792064158675;10421.949739948564;10448.42533660656;10895.782084358427;19359.225630974885;19363.128659210368;19366.128524216445;19376.612467750565;19397.806021939883;6787.626680532618;6853.485988550879;6928.099347084947;6951.200611929592;6987.231404545496;3519.1554027033326;3532.7703699259464;3538.522299489536;3556.448750443685;3618.7647802893252;2680.182544323961;2763.557830747071;2769.2107749291354;2770.1689493151976;2772.875220615077;379.95630502492014;449.5437131311721;464.4171564686297;469.8613908896815;510.48696060459;375.3693794425392;418.61905665844546;422.6808759386705;427.28643165913;427.51263559542144;7272.709091636381;7395.704171833174;7554.2823431773895;7572.129205141369;7578.242175782378;432.5825578316939;448.5940224097132;459.9701019433793;493.5286801105008;501.2105933155295;3627.764195327295;3662.377395842713;3717.2565486902727;3725.323340748167;3757;50778.23832642513;51320.48679513232;51359.74320128375;51396.74301628468;61941;51633.7418312906;65370;87280.56359718161;87458.56270718733;87493.56253218693;79215;79340;79508;82223.5888820552;82236;6942.826429339307;6949.30506949301;7095.609741464269;7118;7152.499325047197;46122.76938615285;47228.52771472379;47252.29121563248;48645;48939.51060489492;37113.257734844614;54038.45961540334;55930;56761.71619141878;62665.68667156635;11280.492377842853;11286.943565282121;11327.376994265065;11369.431528423711;11549.249298795552;12313.569025084438;12366.814497782361;12379.195352302071;12556.497740090294;12849.293288869201;11026;11436.370999595103;11491.712707182387;11641.88358116408;11657.53369865196;10462.476876156314;10606.469676516297;10911.127109831035;11121.666350009513;11130.721731956766;10909.290896091728;10945.890541094486;11460.541578336773;11526.423678816192;11533.826992595286;9438;9718.75703107428;9783.510824458606;9919.355241909252;9957.402555846673;9304.674336398193;9767.951160244153;9807.460589667637;9816.312858099864;9880.50597470138 10:29:06 INFO - PROCESS | 28713 | __end_tp_report 10:29:06 INFO - PROCESS | 28713 | __start_cc_report 10:29:06 INFO - PROCESS | 28713 | _x_x_mozilla_cycle_collect,850 10:29:06 INFO - PROCESS | 28713 | __end_cc_report 10:29:06 INFO - PROCESS | 28713 | __startTimestamp1468430946486__endTimestamp 10:29:06 INFO - PROCESS | 28713 | 10:29:06 INFO - PROCESS | 28713 | ------- Summary: start ------- 10:29:06 INFO - PROCESS | 28713 | Number of tests: 6 10:29:06 INFO - PROCESS | 28713 | 10:29:06 INFO - PROCESS | 28713 | [#0] dojo.html Cycles:165 Average:4561.95 Median:4713.60 stddev:485.13 (10.3%) stddev-sans-first:460.90 10:29:06 INFO - PROCESS | 28713 | Values: 2574.9 2584.2 2609.6 2626.3 2627.8 4437.0 4533.4 4543.3 4578.8 4599.4 4589.3 4618.0 4626.3 4664.5 4668.7 4069.2 4214.2 4308.8 4331.2 4394.9 4297.3 4367.1 4369.4 4379.8 4409.3 4094.5 4133.9 4144.0 4198.0 4203.8 4219.2 4220.0 4235.3 4271.1 4283.9 4254.9 4270.0 4275.6 4303.0 4317.7 4402.3 4486.6 4570.2 4575.5 4612.5 4872.7 4898.3 4936.2 4941.0 4944.8 4808.1 4891.6 4915.4 4955.9 4959.0 4577.1 4628.9 4632.5 4642.6 4643.1 5072.2 5105.7 5129.9 5134.4 5144.7 4696.0 4800.8 4917.6 4922.3 4928.9 4964.7 4995.5 4998.4 5014.9 5016.2 4904.2 4916.4 4918.3 4919.6 4976.1 4684.5 4740.2 4790.7 4900.8 4912.5 4049.4 4049.8 4064.9 4096.8 4105.7 3606.3 3611.6 3614.0 3630.1 3655.4 4092.7 4136.2 4256.3 4267.8 4290.2 4936.9 4989.9 4991.4 4992.5 5041.5 4322.8 4324.5 4329.2 4361.5 4369.2 4208.9 4346.7 4401.6 4404.1 4415.4 4714.2 4738.1 4738.2 4739.0 4783.8 5005.2 5006.0 5015.6 5019.9 5065.8 4497.3 4670.4 4711.1 4716.4 4731.7 4881.5 4906.3 4907.1 4912.0 4967.5 4773.3 4972.9 4987.1 4995.9 5031.5 4742.4 4760.4 4788.0 4790.6 4793.6 4757.9 4785.0 4786.8 4792.3 4840.6 4566.2 4684.0 4713.6 4761.2 4764.6 4821.0 4838.1 4859.0 4860.3 4910.6 4749.6 4750.8 4753.1 4753.1 4800.0 10:29:06 INFO - PROCESS | 28713 | 10:29:06 INFO - PROCESS | 28713 | [#1] ext.html Cycles:180 Average:44208.61 Median:35701.50 stddev:83682.80 (234.4%) stddev-sans-first:83853.40 10:29:06 INFO - PROCESS | 28713 | Values: 563.6 578.8 581.9 584.7 592.7 28778.6 31389.7 31547.8 39052.6 40140.2 40140.6 40868.6 40899.8 40940.0 41002.6 7700.1 7845.6 7853.5 7859.5 7859.7 7841.7 7924.4 7930.5 7931.7 7932.4 7891.4 7914.9 7923.9 7929.6 7938.7 7877.0 7903.7 7911.0 7920.0 7922.6 7643.8 7714.8 7720.7 7724.2 7726.6 37598.6 37964.8 38014.4 38017.4 38022.6 2763.7 2781.7 2836.6 2857.9 2903.7 29413.4 29533.6 29758.7 29957.0 30011.7 2667.5 2680.0 2703.7 2758.2 2786.6 183861.1 183873.0 184706.0 184957.0 185177.0 31632.4 32585.8 51290.7 51657.0 51687.5 33936.8 33976.5 34036.3 34112.1 34112.5 13301.6 13406.2 13412.4 13416.5 13420.8 10431.3 10434.4 10437.1 10454.3 10457.4 7839.3 7873.7 7880.3 7932.3 7939.8 3101.2 3122.4 3123.0 3138.9 3153.9 794.2 816.2 821.2 843.1 931.7 26917.6 27194.7 27507.4 27577.4 27899.7 874.6 903.2 930.8 944.7 1029.4 13577.6 13586.7 13594.5 13769.8 13788.5 412610.0 419166.0 419368.0 419586.0 420118.0 48024.0 48652.5 48694.0 48728.6 48753.5 1052.7 1173.2 1175.6 1191.2 1209.9 27914.4 28454.1 28585.0 28969.7 29528.0 40411.2 40569.0 40690.4 40889.2 41000.8 298279.0 298302.0 300305.0 300349.0 300383.0 21717.6 23919.9 24277.6 24580.8 24810.3 41550.4 41845.5 41888.4 42232.8 42769.4 35182.8 35857.6 36118.8 36486.3 36557.6 35452.5 35772.0 36244.5 36323.6 36429.0 35137.6 35353.9 35631.0 36151.1 36258.8 26594.0 28153.6 28273.6 28322.9 28394.6 24879.6 24921.4 24929.9 25086.2 25093.9 10:29:06 INFO - PROCESS | 28713 | 10:29:06 INFO - PROCESS | 28713 | [#2] jquery.html Cycles:180 Average:25253.95 Median:49568.00 stddev:61714.53 (124.5%) stddev-sans-first:61859.29 10:29:06 INFO - PROCESS | 28713 | Values: 333.6 364.9 373.8 377.8 395.4 12926.1 16489.3 16673.7 18776.5 18777.1 16597.4 17197.0 17858.5 17913.8 18211.6 4927.5 5001.4 5132.8 5136.5 5139.2 3715.6 5029.5 5665.3 6053.3 6074.1 6043.7 6095.8 6103.7 6108.9 6136.7 6013.3 6130.4 6140.5 6157.6 6184.3 3420.6 5029.3 5337.1 5351.2 5396.7 22037.0 22192.0 22425.8 22513.0 22863.5 1723.8 1775.1 1816.1 1847.2 1948.5 13212.3 13577.9 13635.5 13978.8 14043.2 1761.2 2040.7 2042.7 2146.3 2197.0 79673.6 82564.0 82953.0 83049.6 84033.2 14166.4 14676.6 16602.8 17184.7 17474.9 29506.9 29548.9 29685.6 29762.7 29856.7 9175.4 9280.2 9282.5 9307.6 9458.6 7666.9 7713.6 7811.4 7833.1 7846.6 8413.9 8594.8 8648.9 8716.6 8920.7 3151.7 3155.8 3161.0 3299.7 3323.2 816.4 823.8 903.3 911.1 913.3 16852.0 17155.3 17726.5 17734.3 17853.3 819.4 820.3 833.6 867.0 875.9 9158.0 9854.2 9969.8 10021.6 10169.8 362513.0 365167.0 367450.0 380223.0 380743.0 79749.6 79936.0 80358.2 82542.0 83507.6 806.4 830.3 834.9 836.7 843.9 12160.6 16322.0 16351.4 16374.6 16572.7 39139.4 39394.4 39442.2 39565.8 39747.0 48137.8 48897.3 49445.5 49690.5 50489.2 7333.8 7346.2 7376.4 7490.9 7933.9 9950.3 10961.6 11323.0 11342.1 11388.4 9421.2 9446.9 9634.2 9698.0 9707.7 10008.5 10216.8 10307.1 10344.1 10466.4 9658.6 9790.8 10030.6 10454.2 10497.4 6951.9 7023.7 7086.5 7149.0 7259.3 5013.9 6024.7 7930.7 9637.3 10282.7 10:29:06 INFO - PROCESS | 28713 | 10:29:06 INFO - PROCESS | 28713 | [#3] mootools.html Cycles:180 Average:5179.04 Median:5486.59 stddev:2932.15 (53.4%) stddev-sans-first:2926.39 10:29:06 INFO - PROCESS | 28713 | Values: 1368.5 1420.8 1498.8 1646.2 1698.2 7650.3 8101.0 8190.9 8191.4 8192.0 6596.6 6808.8 7605.5 7843.3 7947.9 2181.5 2203.7 2205.1 2213.2 2214.1 2197.5 2203.0 2249.9 2255.2 2255.4 1822.6 2112.7 2181.1 2196.3 2205.0 2175.2 2176.2 2187.6 2189.2 2214.2 2149.6 2151.2 2153.7 2158.2 2158.2 8029.8 8085.6 8089.4 8093.5 8096.5 4437.6 4491.8 4571.3 4573.3 4583.7 2563.1 2677.3 2689.9 2692.9 2714.6 774.5 794.9 804.6 809.8 817.4 10574.9 10696.4 10717.3 10724.1 10794.6 3935.0 4048.8 4127.4 4136.9 4259.7 9168.5 9175.7 9177.8 9185.0 9243.4 4671.1 4677.0 4686.1 4698.2 4705.8 4164.9 4217.8 4237.7 4241.4 4249.7 3702.7 3722.3 3751.1 3827.8 3835.8 1073.4 1171.2 1184.5 1204.2 1207.8 668.6 728.2 835.2 836.4 856.9 5480.9 5492.3 5509.9 5525.1 5721.5 810.8 843.4 848.0 881.0 897.1 3471.7 3587.5 3587.8 3592.3 3630.1 9544.0 9818.9 10001.6 10006.4 10019.1 8218.4 9186.1 9631.8 9632.8 9906.6 7391.4 7545.4 7560.4 7569.6 7590.9 5445.6 5477.0 5505.9 5719.7 5772.9 8950.4 9184.4 9293.0 9302.1 9322.0 8945.3 9247.4 9303.4 9320.9 9328.9 6677.0 6783.2 6783.7 6791.4 6793.9 7463.0 7537.5 7542.4 7544.4 7545.4 6730.8 6870.2 6899.2 6960.5 7041.8 6657.4 6788.5 6812.9 6864.5 6933.1 6194.3 6219.7 6247.0 6268.8 6310.5 4367.7 4389.3 4479.8 4497.9 4534.0 4426.7 4432.4 4450.9 4523.1 4560.3 10:29:06 INFO - PROCESS | 28713 | 10:29:06 INFO - PROCESS | 28713 | [#4] prototype.html Cycles:180 Average:4186.27 Median:4796.24 stddev:1211.32 (25.3%) stddev-sans-first:1179.06 10:29:06 INFO - PROCESS | 28713 | Values: 299.3 300.5 300.5 302.8 306.8 4801.3 4810.1 4837.3 4847.7 4877.2 4741.1 4783.4 4791.2 4820.9 4825.1 3627.6 3692.4 3750.7 3795.4 3823.8 3794.1 3796.4 3809.7 3813.0 3826.3 3618.2 3780.2 3803.7 3819.6 3820.7 3528.5 3719.2 3735.3 3741.3 3809.8 3358.6 3362.7 3363.1 3370.2 3381.7 4707.2 4726.4 4735.7 4739.1 4764.1 4246.1 4316.5 4326.5 4358.2 4364.9 4921.6 4979.0 4979.4 4987.3 5013.6 3660.0 3666.2 3673.3 3679.5 3697.4 4977.4 5294.6 5303.7 5315.3 5315.5 3643.5 3649.3 3671.1 3676.6 3679.4 3717.7 3718.8 3720.4 3720.9 3727.3 4245.9 4254.1 4263.8 4274.7 4280.1 4790.1 5030.8 5033.3 5042.3 5049.8 1282.9 1288.9 1295.5 1295.7 1295.9 795.7 821.0 833.6 837.3 838.5 4232.5 4351.7 4466.6 4469.7 4484.9 5173.8 5188.9 5198.2 5234.9 5234.9 4437.3 4445.3 4450.0 4453.0 4476.1 2638.8 2738.3 2756.0 2758.8 2760.7 4891.3 4895.3 4921.7 4945.7 4979.2 5079.9 5225.3 5260.0 5293.7 5348.5 4908.5 4916.4 4921.7 4940.8 4941.6 5181.0 5183.6 5189.6 5194.5 5227.3 4901.5 5026.3 5070.7 5116.3 5137.0 4893.8 4905.4 4920.8 4931.2 4940.7 3664.6 3671.5 3679.2 3687.0 3697.2 4960.5 5186.3 5195.2 5222.8 5229.2 5010.8 5014.2 5019.2 5025.2 5035.9 4978.2 4989.6 5001.4 5025.6 5033.5 4748.5 4901.7 4904.6 4926.0 4938.5 4741.9 4822.3 5018.0 5032.6 5063.0 4943.1 4943.3 4953.6 4956.4 4957.8 10:29:06 INFO - PROCESS | 28713 | 10:29:06 INFO - PROCESS | 28713 | [#5] yui.html Cycles:180 Average:16221.37 Median:23291.37 stddev:21842.48 (93.8%) stddev-sans-first:21872.27 10:29:06 INFO - PROCESS | 28713 | Values: 602.5 662.9 665.1 677.4 698.0 13222.1 13274.1 13714.7 14152.6 14154.7 12685.5 12697.6 12811.3 12811.5 12834.8 625.5 763.2 780.4 794.9 802.0 794.8 794.8 797.2 797.2 797.4 829.0 832.9 834.4 835.0 835.9 652.9 794.2 821.2 823.5 826.3 605.7 606.4 607.0 607.2 607.2 13328.3 13334.0 13365.1 13385.6 13392.7 12790.6 13192.9 13240.8 13268.1 13518.6 11323.1 11564.9 11604.9 11912.9 12034.0 4028.7 4058.9 4151.8 4195.3 4268.1 59680.4 59866.0 59904.0 61377.0 61702.4 10181.1 10396.8 10421.9 10448.4 10895.8 19359.2 19363.1 19366.1 19376.6 19397.8 6787.6 6853.5 6928.1 6951.2 6987.2 3519.2 3532.8 3538.5 3556.4 3618.8 2680.2 2763.6 2769.2 2770.2 2772.9 380.0 449.5 464.4 469.9 510.5 375.4 418.6 422.7 427.3 427.5 7272.7 7395.7 7554.3 7572.1 7578.2 432.6 448.6 460.0 493.5 501.2 3627.8 3662.4 3717.3 3725.3 3757.0 50778.2 51320.5 51359.7 51396.7 61941.0 51633.7 65370.0 87280.6 87458.6 87493.6 79215.0 79340.0 79508.0 82223.6 82236.0 6942.8 6949.3 7095.6 7118.0 7152.5 46122.8 47228.5 47252.3 48645.0 48939.5 37113.3 54038.5 55930.0 56761.7 62665.7 11280.5 11286.9 11327.4 11369.4 11549.2 12313.6 12366.8 12379.2 12556.5 12849.3 11026.0 11436.4 11491.7 11641.9 11657.5 10462.5 10606.5 10911.1 11121.7 11130.7 10909.3 10945.9 11460.5 11526.4 11533.8 9438.0 9718.8 9783.5 9919.4 9957.4 9304.7 9768.0 9807.5 9816.3 9880.5 10:29:06 INFO - PROCESS | 28713 | -------- Summary: end -------- 10:29:06 INFO - PROCESS | 28713 | 10:29:07 INFO - TEST-INFO | 28713: exit 0 10:29:07 INFO - TEST-OK | dromaeo_css | took 1118991ms 10:29:07 INFO - TEST-START | kraken 10:29:07 INFO - operating with platform_type : linux_ 10:29:07 INFO - Initialising browser for kraken test... 10:29:07 INFO - TEST-INFO | started process 28903 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_KSJKc/profile http://localhost:34499/getInfo.html) 10:29:11 INFO - PROCESS | 28903 | __metrics Screen width/height:1600/1200 10:29:11 INFO - PROCESS | 28903 | colorDepth:24 10:29:11 INFO - PROCESS | 28903 | Browser inner width/height: 1024/697 10:29:11 INFO - PROCESS | 28903 | __metrics 10:29:12 INFO - PROCESS | 28903 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:29:12 INFO - PROCESS | 28903 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:29:13 INFO - TEST-INFO | 28903: exit 0 10:29:13 INFO - Browser initialized. 10:29:13 INFO - Running cycle 1/1 for kraken test... 10:29:13 INFO - TEST-INFO | started process 28982 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_KSJKc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:29:25 INFO - PROCESS | 28982 | RSS: Main: 158707712 10:29:25 INFO - PROCESS | 28982 | 10:29:27 INFO - PROCESS | 28982 | Cycle 1(1): loaded http://localhost:34499/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34499/tests/kraken/driver.html?testName=audio-beat-detection) 10:29:28 INFO - PROCESS | 28982 | RSS: Main: 217223168 10:29:28 INFO - PROCESS | 28982 | 10:29:31 INFO - PROCESS | 28982 | Cycle 1(1): loaded http://localhost:34499/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34499/tests/kraken/driver.html?testName=audio-dft) 10:29:32 INFO - PROCESS | 28982 | RSS: Main: 204619776 10:29:32 INFO - PROCESS | 28982 | 10:29:35 INFO - PROCESS | 28982 | Cycle 1(1): loaded http://localhost:34499/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34499/tests/kraken/driver.html?testName=audio-fft) 10:29:35 INFO - PROCESS | 28982 | RSS: Main: 271286272 10:29:35 INFO - PROCESS | 28982 | 10:29:38 INFO - PROCESS | 28982 | Cycle 1(1): loaded http://localhost:34499/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34499/tests/kraken/driver.html?testName=audio-oscillator) 10:29:38 INFO - PROCESS | 28982 | RSS: Main: 182136832 10:29:38 INFO - PROCESS | 28982 | 10:29:40 INFO - PROCESS | 28982 | Cycle 1(1): loaded http://localhost:34499/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34499/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:29:41 INFO - PROCESS | 28982 | RSS: Main: 185679872 10:29:41 INFO - PROCESS | 28982 | 10:29:44 INFO - PROCESS | 28982 | Cycle 1(1): loaded http://localhost:34499/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34499/tests/kraken/driver.html?testName=imaging-darkroom) 10:29:45 INFO - PROCESS | 28982 | RSS: Main: 222420992 10:29:45 INFO - PROCESS | 28982 | 10:29:48 INFO - PROCESS | 28982 | Cycle 1(1): loaded http://localhost:34499/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34499/tests/kraken/driver.html?testName=imaging-desaturate) 10:29:49 INFO - PROCESS | 28982 | RSS: Main: 222326784 10:29:49 INFO - PROCESS | 28982 | 10:29:52 INFO - PROCESS | 28982 | Cycle 1(1): loaded http://localhost:34499/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34499/tests/kraken/driver.html?testName=json-parse-financial) 10:29:52 INFO - PROCESS | 28982 | RSS: Main: 222261248 10:29:52 INFO - PROCESS | 28982 | 10:29:54 INFO - PROCESS | 28982 | Cycle 1(1): loaded http://localhost:34499/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34499/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:29:55 INFO - PROCESS | 28982 | RSS: Main: 210468864 10:29:55 INFO - PROCESS | 28982 | 10:29:57 INFO - PROCESS | 28982 | Cycle 1(1): loaded http://localhost:34499/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34499/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:29:57 INFO - PROCESS | 28982 | RSS: Main: 214286336 10:29:57 INFO - PROCESS | 28982 | 10:29:59 INFO - PROCESS | 28982 | Cycle 1(1): loaded http://localhost:34499/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34499/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:30:00 INFO - PROCESS | 28982 | RSS: Main: 212238336 10:30:00 INFO - PROCESS | 28982 | 10:30:03 INFO - PROCESS | 28982 | Cycle 1(1): loaded http://localhost:34499/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34499/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:30:03 INFO - PROCESS | 28982 | RSS: Main: 226779136 10:30:03 INFO - PROCESS | 28982 | 10:30:06 INFO - PROCESS | 28982 | Cycle 1(1): loaded http://localhost:34499/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34499/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:30:07 INFO - PROCESS | 28982 | RSS: Main: 227721216 10:30:07 INFO - PROCESS | 28982 | 10:30:09 INFO - PROCESS | 28982 | Cycle 1(1): loaded http://localhost:34499/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34499/tests/kraken/driver.html?testName=ai-astar) 10:30:09 INFO - PROCESS | 28982 | RSS: Main: 270114816 10:30:09 INFO - PROCESS | 28982 | 10:30:09 INFO - PROCESS | 28982 | __start_tp_report 10:30:09 INFO - PROCESS | 28982 | _x_x_mozilla_page_load 10:30:09 INFO - PROCESS | 28982 | _x_x_mozilla_page_load_details 10:30:09 INFO - PROCESS | 28982 | |i|pagename|runs| 10:30:09 INFO - PROCESS | 28982 | |0;ai-astar;106;117;115;113;113;113;113;112;113;114 10:30:09 INFO - PROCESS | 28982 | |1;audio-beat-detection;146;123;125;171;127;122;144;121;161;124 10:30:09 INFO - PROCESS | 28982 | |2;audio-dft;161;162;162;161;161;160;162;163;161;169 10:30:09 INFO - PROCESS | 28982 | |3;audio-fft;77;74;76;126;76;76;74;75;98;76 10:30:09 INFO - PROCESS | 28982 | |4;audio-oscillator;85;85;129;85;85;84;129;84;85;122 10:30:09 INFO - PROCESS | 28982 | |5;imaging-gaussian-blur;117;117;116;117;116;117;117;117;116;116 10:30:09 INFO - PROCESS | 28982 | |6;imaging-darkroom;147;147;146;146;147;146;146;145;147;146 10:30:09 INFO - PROCESS | 28982 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 10:30:09 INFO - PROCESS | 28982 | |8;json-parse-financial;65;64;63;64;65;65;65;64;64;65 10:30:09 INFO - PROCESS | 28982 | |9;json-stringify-tinderbox;66;66;65;65;67;66;66;66;66;66 10:30:09 INFO - PROCESS | 28982 | |10;stanford-crypto-aes;78;79;80;79;79;80;77;86;84;82 10:30:09 INFO - PROCESS | 28982 | |11;stanford-crypto-ccm;126;129;127;128;127;141;127;128;173;148 10:30:09 INFO - PROCESS | 28982 | |12;stanford-crypto-pbkdf2;164;164;163;167;166;166;169;171;164;177 10:30:09 INFO - PROCESS | 28982 | |13;stanford-crypto-sha256-iterative;71;67;70;67;65;65;66;66;65;64 10:30:09 INFO - PROCESS | 28982 | __end_tp_report 10:30:09 INFO - PROCESS | 28982 | __start_cc_report 10:30:09 INFO - PROCESS | 28982 | _x_x_mozilla_cycle_collect,1890 10:30:09 INFO - PROCESS | 28982 | __end_cc_report 10:30:09 INFO - PROCESS | 28982 | __startTimestamp1468431009354__endTimestamp 10:30:09 INFO - PROCESS | 28982 | 10:30:09 INFO - PROCESS | 28982 | ------- Summary: start ------- 10:30:09 INFO - PROCESS | 28982 | Number of tests: 14 10:30:09 INFO - PROCESS | 28982 | 10:30:09 INFO - PROCESS | 28982 | [#0] ai-astar Cycles:10 Average:112.90 Median:113.00 stddev:2.81 (2.5%) stddev-sans-first:1.50 10:30:09 INFO - PROCESS | 28982 | Values: 106.0 117.0 115.0 113.0 113.0 113.0 113.0 112.0 113.0 114.0 10:30:09 INFO - PROCESS | 28982 | 10:30:09 INFO - PROCESS | 28982 | [#1] audio-beat-detection Cycles:10 Average:136.40 Median:135.50 stddev:18.10 (13.4%) stddev-sans-first:18.86 10:30:09 INFO - PROCESS | 28982 | Values: 146.0 123.0 125.0 171.0 127.0 122.0 144.0 121.0 161.0 124.0 10:30:09 INFO - PROCESS | 28982 | 10:30:09 INFO - PROCESS | 28982 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.00 stddev:2.53 (1.6%) stddev-sans-first:2.65 10:30:09 INFO - PROCESS | 28982 | Values: 161.0 162.0 162.0 161.0 161.0 160.0 162.0 163.0 161.0 169.0 10:30:09 INFO - PROCESS | 28982 | 10:30:09 INFO - PROCESS | 28982 | [#3] audio-fft Cycles:10 Average:82.80 Median:76.00 stddev:16.77 (22.1%) stddev-sans-first:17.66 10:30:09 INFO - PROCESS | 28982 | Values: 77.0 74.0 76.0 126.0 76.0 76.0 74.0 75.0 98.0 76.0 10:30:09 INFO - PROCESS | 28982 | 10:30:09 INFO - PROCESS | 28982 | [#4] audio-oscillator Cycles:10 Average:97.30 Median:85.00 stddev:20.36 (24.0%) stddev-sans-first:21.10 10:30:09 INFO - PROCESS | 28982 | Values: 85.0 85.0 129.0 85.0 85.0 84.0 129.0 84.0 85.0 122.0 10:30:09 INFO - PROCESS | 28982 | 10:30:09 INFO - PROCESS | 28982 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 10:30:09 INFO - PROCESS | 28982 | Values: 117.0 117.0 116.0 117.0 116.0 117.0 117.0 117.0 116.0 116.0 10:30:09 INFO - PROCESS | 28982 | 10:30:09 INFO - PROCESS | 28982 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.50 stddev:0.67 (0.5%) stddev-sans-first:0.67 10:30:09 INFO - PROCESS | 28982 | Values: 147.0 147.0 146.0 146.0 147.0 146.0 146.0 145.0 147.0 146.0 10:30:09 INFO - PROCESS | 28982 | 10:30:09 INFO - PROCESS | 28982 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 10:30:09 INFO - PROCESS | 28982 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 10:30:09 INFO - PROCESS | 28982 | 10:30:09 INFO - PROCESS | 28982 | [#8] json-parse-financial Cycles:10 Average:64.40 Median:65.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 10:30:09 INFO - PROCESS | 28982 | Values: 65.0 64.0 63.0 64.0 65.0 65.0 65.0 64.0 64.0 65.0 10:30:09 INFO - PROCESS | 28982 | 10:30:09 INFO - PROCESS | 28982 | [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:66.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 10:30:09 INFO - PROCESS | 28982 | Values: 66.0 66.0 65.0 65.0 67.0 66.0 66.0 66.0 66.0 66.0 10:30:09 INFO - PROCESS | 28982 | 10:30:09 INFO - PROCESS | 28982 | [#10] stanford-crypto-aes Cycles:10 Average:80.40 Median:80.00 stddev:2.80 (3.5%) stddev-sans-first:2.83 10:30:09 INFO - PROCESS | 28982 | Values: 78.0 79.0 80.0 79.0 79.0 80.0 77.0 86.0 84.0 82.0 10:30:09 INFO - PROCESS | 28982 | 10:30:09 INFO - PROCESS | 28982 | [#11] stanford-crypto-ccm Cycles:10 Average:135.40 Median:128.50 stddev:15.11 (11.8%) stddev-sans-first:15.64 10:30:09 INFO - PROCESS | 28982 | Values: 126.0 129.0 127.0 128.0 127.0 141.0 127.0 128.0 173.0 148.0 10:30:09 INFO - PROCESS | 28982 | 10:30:09 INFO - PROCESS | 28982 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.10 Median:166.50 stddev:4.28 (2.6%) stddev-sans-first:4.39 10:30:09 INFO - PROCESS | 28982 | Values: 164.0 164.0 163.0 167.0 166.0 166.0 169.0 171.0 164.0 177.0 10:30:09 INFO - PROCESS | 28982 | 10:30:09 INFO - PROCESS | 28982 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:66.50 stddev:2.27 (3.4%) stddev-sans-first:1.76 10:30:09 INFO - PROCESS | 28982 | Values: 71.0 67.0 70.0 67.0 65.0 65.0 66.0 66.0 65.0 64.0 10:30:09 INFO - PROCESS | 28982 | -------- Summary: end -------- 10:30:09 INFO - PROCESS | 28982 | 10:30:10 INFO - TEST-INFO | 28982: exit 0 10:30:10 INFO - TEST-OK | kraken | took 63165ms 10:30:10 INFO - SUITE-END | took 1182s 10:30:10 INFO - Completed test suite (00:19:42) 10:30:10 INFO - javascript benchmark 10:30:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2574.9098781542643, 2584.2247325802255, 2609.556375416179, 2626.3302857771264, 2627.802914781391, 4437.0, 4533.365328853963, 4543.341215523747, 4578.839740609079, 4599.379083823683, 4589.265717485203, 4617.984043510422, 4626.282926146444, 4664.463586687532, 4668.696534725249, 4069.165821006701, 4214.1993021325925, 4308.806103725325, 4331.220380331539, 4394.934075988863, 4297.290946993742, 4367.1265746850595, 4369.388285640013, 4379.846705365313, 4409.316555933835, 4094.508658960914, 4133.937990930139, 4144.046869220097, 4197.97901010496, 4203.7687927164, 4219.219444402765, 4220.029393239542, 4235.343521754133, 4271.081717430768, 4283.87148385549, 4254.893627659302, 4270.0, 4275.551067137968, 4303.031817840961, 4317.69776115672, 4402.3176407656865, 4486.55134486552, 4570.245909424941, 4575.496695363508, 4612.469565999886, 4872.6832755870755, 4898.289747986558, 4936.234883593013, 4940.950590494085, 4944.7527623619035, 4808.134535783557, 4891.633127515451, 4915.361003069614, 4955.900881982377, 4959.0, 4577.06170235101, 4628.884277893012, 4632.513586073481, 4642.605378542862, 4643.094596553708, 5072.188449848007, 5105.693658380509, 5129.8717532061255, 5134.409542902539, 5144.6655967362, 4696.03731235096, 4800.807967681254, 4917.582005529499, 4922.310876477296, 4928.901421971541, 4964.652474326763, 4995.525425084611, 4998.375203099613, 5014.89970200594, 5016.172331565251, 4904.190808516555, 4916.360873086476, 4918.311436398907, 4919.581835544019, 4976.0794253063295, 4684.531546845288, 4740.170470167707, 4790.736509491941, 4900.803967841246, 4912.484189160158, 4049.4128351388886, 4049.7772622506045, 4064.8577299794365, 4096.795160241976, 4105.7331273467125, 3606.3328284267495, 3611.6207798180812, 3614.0, 3630.0743310455664, 3655.415133578668, 4092.6725861930972, 4136.172765446922, 4256.29771087767, 4267.8079486423185, 4290.163418133497, 4936.876578085505, 4989.850304490871, 4991.376077990251, 4992.450830408652, 5041.470645582234, 4322.805473753689, 4324.481062272547, 4329.220740266782, 4361.520232774392, 4369.191699535532, 4208.873733787991, 4346.695731298842, 4401.625861801719, 4404.0971600822395, 4415.448068991376, 4714.198586240279, 4738.052389522179, 4738.218193997952, 4739.004808990082, 4783.760811959319, 5005.174146265971, 5006.048850718352, 5015.64890457679, 5019.899602008012, 5065.772040258271, 4497.280435130363, 4670.439547254351, 4711.104890070876, 4716.363290955677, 4731.739754313546, 4881.463039065771, 4906.288588154769, 4907.141250281115, 4911.9754401227765, 4967.503249675004, 4773.331733557236, 4972.925406118983, 4987.102321582005, 4995.850124496271, 5031.471695471922, 4742.430908291027, 4760.404949381327, 4787.952120478751, 4790.640701947298, 4793.640476964311, 4757.928631070467, 4785.042991401664, 4786.832460863853, 4792.305115758265, 4840.636952228527, 4566.178087944069, 4683.992941517454, 4713.599344055794, 4761.214399624023, 4764.571188593043, 4820.9517904820505, 4838.080764654705, 4858.951410485991, 4860.343853579721, 4910.631702622246, 4749.596284315872, 4750.833720819893, 4753.073150735573, 4753.1444340019125, 4800.0], "value": 4530.979096421547, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.5716855190054, 578.7800635758416, 581.9185314056033, 584.7456356484929, 592.6562593695656, 28778.56832147517, 31389.686103138964, 31547.842260788722, 39052.60947390525, 40140.183178018604, 40140.59859401405, 40868.59131408685, 40899.795501022454, 40940.0, 41002.58997410025, 7700.075990881102, 7845.64694588742, 7853.450258481908, 7859.528428294292, 7859.68561257549, 7841.725539606115, 7924.445288829785, 7930.484518506308, 7931.682732690685, 7932.444728868982, 7891.368690504746, 7914.920850791505, 7923.9207607924045, 7929.563873986928, 7938.722144724936, 7876.960615196916, 7903.723369682033, 7910.9604451977375, 7919.960400197991, 7922.564258965755, 7643.808904777369, 7714.845703085963, 7720.652570634335, 7724.150343462215, 7726.575038372887, 37598.624013759785, 37964.81017594922, 38014.42978355327, 38017.42973855395, 38022.619773802464, 2763.7236276372405, 2781.6662000560063, 2836.5745138229227, 2857.8571071446554, 2903.651561812575, 29413.41173176546, 29533.556996645068, 29758.70241297581, 29957.0, 30011.749118816177, 2667.493176296517, 2679.954817621129, 2703.6620422447195, 2758.1863350311705, 2786.637737094165, 183861.080694597, 183873.0, 184706.0, 184957.0, 185177.0, 31632.367352653277, 32585.837070814967, 51290.74354628278, 51657.0, 51687.48312516902, 33936.83031584826, 33976.49035264473, 34036.31927361439, 34112.14719631979, 34112.48831267533, 13301.600951971457, 13406.195628262336, 13412.39644215993, 13416.463341466231, 13420.798688019688, 10431.330987042189, 10434.37393756377, 10437.112845408225, 10454.268201225841, 10457.42484163363, 7839.294463498199, 7873.724419645285, 7880.330171935335, 7932.325752311002, 7939.761807145795, 3101.17818778024, 3122.4223518649123, 3123.0, 3138.8744450221734, 3153.936921261562, 794.1740589786557, 816.1919699497455, 821.1542111625035, 843.1020962674854, 931.6552875435997, 26917.596236056474, 27194.728052719616, 27507.436049970493, 27577.44845103087, 27899.721002790116, 874.6151693254948, 903.2251625555683, 930.7859192385654, 944.7354740672623, 1029.3669393323203, 13577.59267221985, 13586.660333491742, 13594.524191653245, 13769.793453098211, 13788.517401891086, 412610.0, 419166.0, 419368.0, 419586.0, 420118.0, 48024.0, 48652.513474865504, 48694.0, 48728.61442470195, 48753.5124648749, 1052.6684094510206, 1173.2139466557428, 1175.623800383869, 1191.195942738648, 1209.9153059285766, 27914.44171116607, 28454.146375608765, 28585.0, 28969.65437366033, 29528.0, 40411.1917761649, 40569.0, 40690.38964415477, 40889.1822163561, 41000.79499602483, 298279.0, 298302.0, 300305.0, 300349.0, 300383.0, 21717.565648687254, 23919.880400597885, 24277.63583546213, 24580.754192457847, 24810.255692329258, 41550.376744349465, 41845.48927064386, 41888.3716744243, 42232.788836055624, 42769.358459623756, 35182.82408587941, 35857.64142358543, 36118.81940590385, 36486.27027459489, 36557.634423656484, 35452.46821297631, 35772.0, 36244.4563331545, 36323.63676363203, 36429.0, 35137.648623513436, 35353.939381818585, 35631.0, 36151.09622259464, 36258.8187059063, 26594.0, 28153.577696334163, 28273.57589636198, 28322.85838570794, 28394.550560957192, 24879.626805597567, 24921.376965576004, 24929.87535062313, 25086.247412577653, 25093.87453062723], "value": 15847.927245042127, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.64133556426845, 364.87411842914196, 373.84859132051514, 377.7752237418735, 395.371359538334, 12926.095173337859, 16489.257983390748, 16673.666526669476, 18776.530586735305, 18777.061146942633, 16597.41909033184, 17196.968181909095, 17858.46424607264, 17913.82086179141, 18211.635767284646, 4927.531884470978, 5001.399832020163, 5132.820351287705, 5136.486351364871, 5139.152039913429, 3715.5912849586525, 5029.547340739333, 5665.291838520185, 6053.273607167124, 6074.149619053336, 6043.724149573738, 6095.817125486243, 6103.664298463583, 6108.908366374508, 6136.693165341738, 6013.308469525995, 6130.417610327012, 6140.539459540552, 6157.63054216744, 6184.28880678721, 3420.640832712554, 5029.346184995964, 5337.092694241988, 5351.2240725095035, 5396.676199428008, 22037.0, 22192.0, 22425.77574224253, 22513.0, 22863.54272914549, 1723.7931448226168, 1775.1301862087614, 1816.1464111867401, 1847.1964695357563, 1948.5226119600648, 13212.273324967124, 13577.932110339483, 13635.454581816715, 13978.790318145237, 14043.22762248076, 1761.1898526677744, 2040.7040979058102, 2042.6629606114973, 2146.3131797824703, 2196.967045494319, 79673.60163199146, 82564.0, 82953.0, 83049.58475207645, 84033.15966840314, 14166.362513686703, 14676.588322896869, 16602.766294595043, 17184.656306874043, 17474.91262543679, 29506.852465737535, 29548.852255739013, 29685.554716679268, 29762.702372976426, 29856.701432985392, 9175.403598766059, 9280.164785169367, 9282.535873206312, 9307.581158847868, 9458.57436415363, 7666.923330766733, 7713.575753333508, 7811.414143939227, 7833.138354780969, 7846.568438735924, 8413.873791893126, 8594.78513037179, 8648.913510864937, 8716.564171791386, 8920.687775927941, 3151.68483151683, 3155.763317751132, 3161.0, 3299.7002997002996, 3323.1512537933413, 816.4448175240893, 823.8022874510194, 903.3134817538718, 911.1480765484293, 913.2967614936462, 16852.0, 17155.313787448613, 17726.468205953843, 17734.29062837498, 17853.28586856511, 819.3895547816915, 820.2576668115365, 833.5790425834914, 866.9523176225242, 875.9036505984336, 9158.001509011609, 9854.211663066937, 9969.750756231153, 10021.599136034623, 10169.847452288222, 362513.0, 365167.0, 367450.0, 380223.0, 380743.0, 79749.60125199337, 79936.0, 80358.19641803508, 82541.99999999879, 83507.58246208851, 806.3750593290247, 830.3066939105914, 834.9290310323569, 836.7447928381902, 843.890294261742, 12160.574379896661, 16322.0, 16351.427700030441, 16374.590635234214, 16572.66854662924, 39139.41290880582, 39394.40908386319, 39442.211155777295, 39565.80217098896, 39747.0, 48137.7965550864, 48897.266541002624, 49445.50554494409, 49690.50309496859, 50489.24266136084, 7333.816654583465, 7346.191918888811, 7376.446766492427, 7490.925090749023, 7933.920660793318, 9950.303478756417, 10961.56153753841, 11323.0, 11342.149338799458, 11388.430578471209, 9421.199198068241, 9446.905530944878, 9634.229261659191, 9698.0, 9707.708768736667, 10008.499575021366, 10216.846747298945, 10307.123894468754, 10344.069033786995, 10466.424346660702, 9658.565364558752, 9790.75523111928, 10030.64892728751, 10454.215933804842, 10497.422641754776, 6951.930480695129, 7023.719051238098, 7086.539374940612, 7149.034880291094, 7259.346658800733, 5013.924791128063, 6024.698765061642, 7930.651789195736, 9637.277204209571, 10282.742931426475], "value": 8981.671948337114, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1368.5004973184787, 1420.7939848721935, 1498.7601983682614, 1646.1604581663348, 1698.2018451327879, 7650.2732240437135, 8101.0, 8190.91809081909, 8191.426600137986, 8191.959040204791, 6596.604203747778, 6808.829779255521, 7605.543667379961, 7843.254890785366, 7947.880781788278, 2181.454636340911, 2203.713517242756, 2205.1179528188773, 2213.181122984498, 2214.081156320125, 2197.450637340665, 2202.9559408811815, 2249.910003599854, 2255.221948427798, 2255.4135924659627, 1822.571695651521, 2112.661974084147, 2181.1275489804125, 2196.3191410662744, 2204.9779502205015, 2175.2386664667397, 2176.216562037665, 2187.595294870454, 2189.189999700121, 2214.2250212425524, 2149.57008598281, 2151.1717988574355, 2153.7415510138726, 2158.212252527832, 2158.212252527832, 8029.799255018613, 8085.555294458803, 8089.352851771844, 8093.473924194908, 8096.473729207582, 4437.5784300491405, 4491.775411229425, 4571.291449825282, 4573.291139873325, 4583.724976501388, 2563.0901030134405, 2677.3039009857575, 2689.932751681204, 2692.9192124236306, 2714.5520989036786, 774.4501404003164, 794.8926894869235, 804.569555287924, 809.7530253272749, 817.4155478832604, 10574.894251057467, 10696.411697356642, 10717.303375280582, 10724.14206863449, 10794.622188223375, 3934.9803250983564, 4048.777317247521, 4127.360259159835, 4136.875893723193, 4259.701820872509, 9168.495732734764, 9175.724728258163, 9177.816443671089, 9185.0, 9243.445393276425, 4671.11248862715, 4677.017826256524, 4686.062787442525, 4698.201305778026, 4705.764711764398, 4164.937525937114, 4217.810198541011, 4237.745735255895, 4241.448611680524, 4249.702520823575, 3702.6667599916136, 3722.3299806034634, 3751.099736063325, 3827.8086095695103, 3835.76985380878, 1073.4042606353548, 1171.221137943258, 1184.461070213051, 1204.2292932523192, 1207.8007128823822, 668.5873236638149, 728.1553398058227, 835.1815221083373, 836.3560058754846, 856.8886044814134, 5480.890382192413, 5492.286002819608, 5509.917351239735, 5525.143602741581, 5721.456461636138, 810.8337790752881, 843.4280820724229, 847.9576021198916, 880.9560670605354, 897.1477096758106, 3471.7049050830456, 3587.5336206293014, 3587.8385472653795, 3592.2815436912724, 3630.128769095451, 9544.0, 9818.90181098194, 10001.599936002478, 10006.399616023062, 10019.098281154731, 8218.424710270343, 9186.127317904788, 9631.807363852824, 9632.807343853083, 9906.55420506079, 7391.408687305003, 7545.434092442979, 7560.395168386516, 7569.621518924142, 7590.924090759022, 5445.618806683653, 5477.014137455296, 5505.862353441196, 5719.656820590778, 5772.913406298825, 8950.373473856767, 9184.44893306377, 9293.0, 9302.116298951589, 9322.021187775457, 8945.329100317373, 9247.352685311964, 9303.441793492411, 9320.860187097063, 9328.860067098864, 6676.966615167087, 6783.152105986752, 6783.694733736895, 6791.422729068085, 6793.864122717419, 7462.96268518654, 7537.510061845963, 7542.434317426325, 7544.434167437574, 7545.358644515058, 6730.764423245163, 6870.175578930561, 6899.20659124187, 6960.4779641526075, 7041.788746337618, 6657.434118100015, 6788.456923446014, 6812.8978065328065, 6864.48516361265, 6933.064036355027, 6194.287656919512, 6219.657918814509, 6246.968765156145, 6268.811935641938, 6310.5267104968225, 4367.650587952892, 4389.275769497997, 4479.776011199492, 4497.865064048084, 4533.97733011346, 4426.690131690751, 4432.370460833016, 4450.910981780411, 4523.11799199153, 4560.33875088117], "value": 4137.331685746198, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.2653036794669, 300.5131686667599, 300.51466880987215, 302.833441607116, 306.7637918802522, 4801.303810947411, 4810.134175848346, 4837.298591704201, 4847.733374664396, 4877.195262781637, 4741.146593613148, 4783.35424717663, 4791.185498465261, 4820.855374338776, 4825.107355139302, 3627.6372362763777, 3692.3722967095523, 3750.699944004487, 3795.3547896857463, 3823.8279277432443, 3794.1273507093383, 3796.3735983562815, 3809.6761775248997, 3813.0, 3826.2921359548573, 3618.2220822523154, 3780.185510954743, 3803.7147213958924, 3819.6371344722206, 3820.732548721591, 3528.4883691864534, 3719.1631882826146, 3735.2716220337047, 3741.3078580462566, 3809.7904615246152, 3358.630550639428, 3362.7477939154414, 3363.1423986883187, 3370.2248482848836, 3381.695647391722, 4707.176244157293, 4726.385569875894, 4735.692180008288, 4739.123262196505, 4764.142454358214, 4246.0680390422285, 4316.48202215733, 4326.480822301344, 4358.171947330029, 4364.934525982113, 4921.581665558432, 4978.950210497885, 4979.377577802775, 4987.276844857512, 5013.6490445668815, 3660.0, 3666.1934374437583, 3673.3020726061964, 3679.521662183899, 3697.371446854041, 4977.42759582649, 5294.6029047821185, 5303.655262407931, 5315.309009828737, 5315.468453154731, 3643.4716966039778, 3649.3248748981523, 3671.0822294426393, 3676.5771936227143, 3679.35611268027, 3717.70258379329, 3718.758280711745, 3720.404735242348, 3720.8697695580527, 3727.2731817295366, 4245.893852653647, 4254.106637606075, 4263.786810659517, 4274.6793990450215, 4280.122574872144, 4790.089882922303, 5030.823921162815, 5033.282027704999, 5042.3444952156715, 5049.798008079636, 1282.923024618526, 1288.9226646401246, 1295.546558704446, 1295.6631275868342, 1295.9222446653232, 795.718892582941, 820.9737827715355, 833.6498670558381, 837.3426859914938, 838.4885220015785, 4232.492100947906, 4351.73889566627, 4466.553344665573, 4469.664775141878, 4484.9011992061505, 5173.793048278102, 5188.870278243074, 5198.194279886624, 5234.895302093937, 5234.947650523446, 4437.33439984005, 4445.288374091801, 4450.020995381011, 4452.977735111303, 4476.149531588988, 2638.802089843231, 2738.274357295318, 2756.0, 2758.848263345535, 2760.682521510012, 4891.290762839369, 4895.33912921751, 4921.704697718148, 4945.653804233669, 4979.228219625964, 5079.949200508022, 5225.268462415265, 5259.973700131552, 5293.735313234323, 5348.5186333230195, 4908.490429343037, 4916.410030796327, 4921.729304888194, 4940.75296235194, 4941.579965702884, 5180.9740951295, 5183.585313174862, 5189.6107791915, 5194.4805519447755, 5227.320448341691, 4901.534354236342, 5026.296318515338, 5070.73231692077, 5116.28372027909, 5137.0, 4893.804247830047, 4905.411350637946, 4920.753962301942, 4931.161702510653, 4940.6788558743565, 3664.596894341567, 3671.485991961074, 3679.24575462035, 3687.0229389211345, 3697.22358304759, 4960.487051449342, 5186.273921650896, 5195.19474481456, 5222.817201397933, 5229.163333866563, 5010.774515146754, 5014.24786282046, 5019.196928491424, 5025.170846810235, 5035.92446113316, 4978.153713868579, 4989.575886049726, 5001.399832020181, 5025.6482046256415, 5033.47148549397, 4748.4776674566465, 4901.705897646153, 4904.558589726799, 4926.0, 4938.506149385033, 4741.881452963704, 4822.324874517501, 5017.974910125572, 5032.572231360376, 5063.0, 4943.134951383421, 4943.283223932438, 4953.603711702983, 4956.430010548833, 4957.810125569765], "value": 3799.5868633717128, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [602.4517688903098, 662.8508585568245, 665.0722242471755, 677.3734295776405, 697.9546329488581, 13222.07445478817, 13274.070815042951, 13714.725705485884, 14152.646183845396, 14154.716905661893, 12685.492580296777, 12697.61907142785, 12811.295378754165, 12811.487540498392, 12834.80747788784, 625.4933503861864, 763.1833937686678, 780.4263866058457, 794.8966634337557, 801.995990020052, 794.761571528542, 794.8370584030259, 797.1948332184478, 797.2466019611469, 797.3740613618311, 828.9917100828975, 832.8958880139983, 834.3783881008627, 835.0188528479013, 835.8955130608674, 652.8726898254843, 794.2454668065332, 821.1542111625035, 823.5017814222429, 826.3224156191925, 605.6971514242879, 606.3512042114938, 606.9514438844882, 607.159084667734, 607.2075940897128, 13328.333583320893, 13334.0, 13365.064445488819, 13385.598432046956, 13392.665183370495, 12790.552330668383, 13192.86807131926, 13240.801387979189, 13268.071235013553, 13518.59444216675, 11323.094152467866, 11564.884351156465, 11604.941975290154, 11912.940435297767, 12034.037277017818, 4028.738132021409, 4058.898527536806, 4151.7924103794685, 4195.286801243796, 4268.061026574149, 59680.40319596792, 59866.0, 59904.0, 61377.0, 61702.38297617011, 10181.134603558632, 10396.792064158675, 10421.949739948564, 10448.42533660656, 10895.782084358427, 19359.225630974885, 19363.128659210368, 19366.128524216445, 19376.612467750565, 19397.806021939883, 6787.626680532618, 6853.485988550879, 6928.099347084947, 6951.200611929592, 6987.231404545496, 3519.1554027033326, 3532.7703699259464, 3538.522299489536, 3556.448750443685, 3618.7647802893252, 2680.182544323961, 2763.557830747071, 2769.2107749291354, 2770.1689493151976, 2772.875220615077, 379.95630502492014, 449.5437131311721, 464.4171564686297, 469.8613908896815, 510.48696060459, 375.3693794425392, 418.61905665844546, 422.6808759386705, 427.28643165913, 427.51263559542144, 7272.709091636381, 7395.704171833174, 7554.2823431773895, 7572.129205141369, 7578.242175782378, 432.5825578316939, 448.5940224097132, 459.9701019433793, 493.5286801105008, 501.2105933155295, 3627.764195327295, 3662.377395842713, 3717.2565486902727, 3725.323340748167, 3757.0, 50778.23832642513, 51320.48679513232, 51359.74320128375, 51396.74301628468, 61941.0, 51633.7418312906, 65370.0, 87280.56359718161, 87458.56270718733, 87493.56253218693, 79215.0, 79340.0, 79508.0, 82223.5888820552, 82236.0, 6942.826429339307, 6949.30506949301, 7095.609741464269, 7118.0, 7152.499325047197, 46122.76938615285, 47228.52771472379, 47252.29121563248, 48645.0, 48939.51060489492, 37113.257734844614, 54038.45961540334, 55930.0, 56761.71619141878, 62665.68667156635, 11280.492377842853, 11286.943565282121, 11327.376994265065, 11369.431528423711, 11549.249298795552, 12313.569025084438, 12366.814497782361, 12379.195352302071, 12556.497740090294, 12849.293288869201, 11026.0, 11436.370999595103, 11491.712707182387, 11641.88358116408, 11657.53369865196, 10462.476876156314, 10606.469676516297, 10911.127109831035, 11121.666350009513, 11130.721731956766, 10909.290896091728, 10945.890541094486, 11460.541578336773, 11526.423678816192, 11533.826992595286, 9438.0, 9718.75703107428, 9783.510824458606, 9919.355241909252, 9957.402555846673, 9304.674336398193, 9767.951160244153, 9807.460589667637, 9816.312858099864, 9880.50597470138], "value": 6277.885611407519, "unit": "score"}], "name": "dromaeo_css", "value": 6318.8772030995415, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 117.0, 115.0, 113.0, 113.0, 113.0, 113.0, 112.0, 113.0, 114.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 123.0, 125.0, 171.0, 127.0, 122.0, 144.0, 121.0, 161.0, 124.0], "value": 136.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 161.0, 161.0, 160.0, 162.0, 163.0, 161.0, 169.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 76.0, 126.0, 76.0, 76.0, 74.0, 75.0, 98.0, 76.0], "value": 82.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 129.0, 85.0, 85.0, 84.0, 129.0, 84.0, 85.0, 122.0], "value": 97.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 145.0, 147.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 63.0, 64.0, 65.0, 65.0, 65.0, 64.0, 64.0, 65.0], "value": 64.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 65.0, 67.0, 66.0, 66.0, 66.0, 66.0, 66.0], "value": 65.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 80.0, 79.0, 79.0, 80.0, 77.0, 86.0, 84.0, 82.0], "value": 80.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 129.0, 127.0, 128.0, 127.0, 141.0, 127.0, 128.0, 173.0, 148.0], "value": 135.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 163.0, 167.0, 166.0, 166.0, 169.0, 171.0, 164.0, 177.0], "value": 167.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 67.0, 70.0, 67.0, 65.0, 65.0, 66.0, 66.0, 65.0, 64.0], "value": 66.6, "unit": "score"}], "name": "kraken", "value": 1529.3, "alertThreshold": 2.0}]} 10:30:10 INFO - Return code: 0 10:30:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:30:10 INFO - # TBPL SUCCESS # 10:30:10 INFO - Running post-action listener: _resource_record_post_action 10:30:10 INFO - ##### 10:30:10 INFO - ##### Finished run-tests step (success) 10:30:10 INFO - ##### 10:30:10 INFO - Running post-run listener: _resource_record_post_run 10:30:10 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 0; Write bytes: 539983872; Read time: 0; Write time: 410440 10:30:10 INFO - TinderboxPrint: CPU usage
13.0% 10:30:10 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 10:30:10 INFO - TinderboxPrint: I/O write bytes / time
539,983,872 / 410,440 10:30:10 INFO - TinderboxPrint: CPU idle
8,328.5 (87.0%) 10:30:10 INFO - TinderboxPrint: CPU user
1,200.1 (12.5%) 10:30:10 INFO - TinderboxPrint: Swap in / out
0 / 0 10:30:10 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 250949632; Read time: 0; Write time: 253580 10:30:10 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 289034240; Read time: 0; Write time: 156860 10:30:11 INFO - Running post-run listener: _upload_blobber_files 10:30:11 INFO - Blob upload gear active. 10:30:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:30:11 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 10:30:11 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:30:11 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:30:11 INFO - (blobuploader) - INFO - Open directory for files ... 10:30:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:30:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:30:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:30:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:30:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:30:12 INFO - (blobuploader) - INFO - Done attempting. 10:30:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:30:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:30:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:30:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:30:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:30:13 INFO - (blobuploader) - INFO - Done attempting. 10:30:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:30:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:30:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:30:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:30:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:30:16 INFO - (blobuploader) - INFO - Done attempting. 10:30:16 INFO - (blobuploader) - INFO - Iteration through files over. 10:30:16 INFO - Return code: 0 10:30:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:30:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:30:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4430dae7f540f4ff423d1d425df84310d2c56bf760af99f08bcc279b5a514213b92d01bb6a3223cf3d762b502107e2adc3fff9df0a1730be4fcac5abef850819", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fee6fbe441cd29cfb4c580e6aca03545b3b315a46b4a048b0e46631dd25f484e6e7645e92174dc9c9bc3be780f9e44d5b30142ae871861a445f4f3845195019f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c48bb9af3c4fb6c9fc17b0c7c0e361fdd5ff77f5bfbeb2799b87682d865234b236e780466d8eeb81cd0412afde4ce3cbf66c8dadd496e56e89dc921816ef08e0"} 10:30:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:30:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:30:16 INFO - Contents: 10:30:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4430dae7f540f4ff423d1d425df84310d2c56bf760af99f08bcc279b5a514213b92d01bb6a3223cf3d762b502107e2adc3fff9df0a1730be4fcac5abef850819", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fee6fbe441cd29cfb4c580e6aca03545b3b315a46b4a048b0e46631dd25f484e6e7645e92174dc9c9bc3be780f9e44d5b30142ae871861a445f4f3845195019f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c48bb9af3c4fb6c9fc17b0c7c0e361fdd5ff77f5bfbeb2799b87682d865234b236e780466d8eeb81cd0412afde4ce3cbf66c8dadd496e56e89dc921816ef08e0"} 10:30:16 INFO - Running post-run listener: copy_logs_to_upload_dir 10:30:16 INFO - Copying logs to upload dir... 10:30:16 INFO - mkdir: /builds/slave/test/build/upload/logs 10:30:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.319136 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-07-13 10:30:16.444991) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 10:30:16.449239) ========= 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=bb9b54edd4a927dc735d112f000001d9-1468429778.489520-822991847 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4430dae7f540f4ff423d1d425df84310d2c56bf760af99f08bcc279b5a514213b92d01bb6a3223cf3d762b502107e2adc3fff9df0a1730be4fcac5abef850819", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fee6fbe441cd29cfb4c580e6aca03545b3b315a46b4a048b0e46631dd25f484e6e7645e92174dc9c9bc3be780f9e44d5b30142ae871861a445f4f3845195019f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c48bb9af3c4fb6c9fc17b0c7c0e361fdd5ff77f5bfbeb2799b87682d865234b236e780466d8eeb81cd0412afde4ce3cbf66c8dadd496e56e89dc921816ef08e0"} build_url:https://queue.taskcluster.net/v1/task/C4W1PiDHRNeeMSNBHglpkQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011277 build_url: 'https://queue.taskcluster.net/v1/task/C4W1PiDHRNeeMSNBHglpkQ/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/Firefox-Non-PGO/sha512/4430dae7f540f4ff423d1d425df84310d2c56bf760af99f08bcc279b5a514213b92d01bb6a3223cf3d762b502107e2adc3fff9df0a1730be4fcac5abef850819", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fee6fbe441cd29cfb4c580e6aca03545b3b315a46b4a048b0e46631dd25f484e6e7645e92174dc9c9bc3be780f9e44d5b30142ae871861a445f4f3845195019f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c48bb9af3c4fb6c9fc17b0c7c0e361fdd5ff77f5bfbeb2799b87682d865234b236e780466d8eeb81cd0412afde4ce3cbf66c8dadd496e56e89dc921816ef08e0"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 10:30:16.474723) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 10:30:16.475071) ========= 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=bb9b54edd4a927dc735d112f000001d9-1468429778.489520-822991847 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004492 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 10:30:16.557398) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 10:30:16.557741) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 10:30:16.558112) ========= ========= Total master_lag: 0.16 =========