builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-037 starttime: 1468367883.27 results: success (0) buildid: 20160712152526 builduid: 68a24d63d17e4bbd8ccd4f0bbc4112d6 revision: 53947432322b06f80b079fef73e43d7e6785f81b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 16:58:03.271459) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 16:58:03.271810) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 16:58:03.272077) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 16:58:03.334194) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 16:58:03.334471) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1468367311.993454-570373406 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-12 16:58:03-- 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% 43.0M=0s 2016-07-12 16:58:03 (43.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.197338 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 16:58:03.572013) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 16:58:03.572708) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1468367311.993454-570373406 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.055138 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 16:58:03.642351) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 16:58:03.642713) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 53947432322b06f80b079fef73e43d7e6785f81b --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 53947432322b06f80b079fef73e43d7e6785f81b --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=56c518bb7cbc29fb3c9463e2000001c4-1468367311.993454-570373406 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-12 16:58:03,721 truncating revision to first 12 chars 2016-07-12 16:58:03,721 Setting DEBUG logging. 2016-07-12 16:58:03,721 attempt 1/10 2016-07-12 16:58:03,721 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/53947432322b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-12 16:58:04,018 unpacking tar archive at: mozilla-central-53947432322b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.630864 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 16:58:04.292852) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 16:58:04.293581) ========= script_repo_revision: 53947432322b06f80b079fef73e43d7e6785f81b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 16:58:04.294408) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 16:58:04.295046) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 16:58:04.331971) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-07-12 16:58:04.332314) ========= /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=56c518bb7cbc29fb3c9463e2000001c4-1468367311.993454-570373406 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:58:04 INFO - MultiFileLogger online at 20160712 16:58:04 in /builds/slave/test 16:58:04 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 16:58:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:58:04 INFO - {'append_to_log': False, 16:58:04 INFO - 'base_work_dir': '/builds/slave/test', 16:58:04 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 16:58:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:58:04 INFO - 'branch': 'Firefox-Non-PGO', 16:58:04 INFO - 'buildbot_json_path': 'buildprops.json', 16:58:04 INFO - 'config_files': ('talos/linux_config.py',), 16:58:04 INFO - 'default_actions': ('clobber', 16:58:04 INFO - 'read-buildbot-config', 16:58:04 INFO - 'download-and-extract', 16:58:04 INFO - 'populate-webroot', 16:58:04 INFO - 'create-virtualenv', 16:58:04 INFO - 'install', 16:58:04 INFO - 'run-tests'), 16:58:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:58:04 INFO - 'download_minidump_stackwalk': True, 16:58:04 INFO - 'download_symbols': 'ondemand', 16:58:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:58:04 INFO - 'tooltool.py': '/tools/tooltool.py', 16:58:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:58:04 INFO - '/tools/misc-python/virtualenv.py')}, 16:58:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:58:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:58:04 INFO - 'installer_path': 'installer.exe', 16:58:04 INFO - 'log_level': 'info', 16:58:04 INFO - 'log_name': 'talos', 16:58:04 INFO - 'log_to_console': True, 16:58:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:58:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:58:04 INFO - 'opt_config_files': (), 16:58:04 INFO - 'pip_index': False, 16:58:04 INFO - 'sps_profile': False, 16:58:04 INFO - 'sps_profile_interval': 0, 16:58:04 INFO - 'suite': 'dromaeojs', 16:58:04 INFO - 'system_bits': '32', 16:58:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:58:04 INFO - 'title': 'talos-linux64-ix-037', 16:58:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:58:04 INFO - 'use_talos_json': True, 16:58:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:58:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:58:04 INFO - 'work_dir': 'build'} 16:58:04 INFO - ##### 16:58:04 INFO - ##### Running clobber step. 16:58:04 INFO - ##### 16:58:04 INFO - Running pre-action listener: _resource_record_pre_action 16:58:04 INFO - Running main action method: clobber 16:58:04 INFO - rmtree: /builds/slave/test/build 16:58:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:58:06 INFO - Running post-action listener: _resource_record_post_action 16:58:06 INFO - ##### 16:58:06 INFO - ##### Finished clobber step (success) 16:58:06 INFO - ##### 16:58:06 INFO - ##### 16:58:06 INFO - ##### Running read-buildbot-config step. 16:58:06 INFO - ##### 16:58:06 INFO - Running pre-action listener: _resource_record_pre_action 16:58:06 INFO - Running main action method: read_buildbot_config 16:58:06 INFO - Using buildbot properties: 16:58:06 INFO - { 16:58:06 INFO - "project": "", 16:58:06 INFO - "product": "firefox", 16:58:06 INFO - "script_repo_revision": "production", 16:58:06 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 16:58:06 INFO - "repository": "", 16:58:06 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 16:58:06 INFO - "buildid": "20160712152526", 16:58:06 INFO - "pgo_build": "False", 16:58:06 INFO - "basedir": "/builds/slave/test", 16:58:06 INFO - "buildnumber": 557, 16:58:06 INFO - "slavename": "talos-linux64-ix-037", 16:58:06 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:58:06 INFO - "platform": "ubuntu64_hw", 16:58:06 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 16:58:06 INFO - "branch": "mozilla-central", 16:58:06 INFO - "repo_path": "mozilla-central", 16:58:06 INFO - "revision": "53947432322b06f80b079fef73e43d7e6785f81b", 16:58:06 INFO - "stage_platform": "linux64", 16:58:06 INFO - "builduid": "68a24d63d17e4bbd8ccd4f0bbc4112d6", 16:58:06 INFO - "slavebuilddir": "test" 16:58:06 INFO - } 16:58:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/NUyGDrkhQy6FPXt9gPWAQg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 16:58:06 INFO - Running post-action listener: _resource_record_post_action 16:58:06 INFO - ##### 16:58:06 INFO - ##### Finished read-buildbot-config step (success) 16:58:06 INFO - ##### 16:58:06 INFO - ##### 16:58:06 INFO - ##### Running download-and-extract step. 16:58:06 INFO - ##### 16:58:06 INFO - Running pre-action listener: _resource_record_pre_action 16:58:06 INFO - Running main action method: download_and_extract 16:58:06 INFO - mkdir: /builds/slave/test/build/tests 16:58: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')]} 16:58:06 INFO - https://queue.taskcluster.net/v1/task/NUyGDrkhQy6FPXt9gPWAQg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:58:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUyGDrkhQy6FPXt9gPWAQg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:58:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUyGDrkhQy6FPXt9gPWAQg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:58:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUyGDrkhQy6FPXt9gPWAQg/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 16:58:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUyGDrkhQy6FPXt9gPWAQg/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 16:58:09 INFO - Downloaded 1361 bytes. 16:58:09 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:58:09 INFO - Using the following test package requirements: 16:58:09 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:58:09 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:58:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:58:09 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:58:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:58:09 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:58:09 INFO - u'jsshell-linux-x86_64.zip'], 16:58:09 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:58:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:58:09 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:58:09 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:58:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:58:09 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:58:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:58:09 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:58:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:58:09 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:58:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:58:09 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:58:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:09 INFO - https://queue.taskcluster.net/v1/task/NUyGDrkhQy6FPXt9gPWAQg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:58:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUyGDrkhQy6FPXt9gPWAQg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:58:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUyGDrkhQy6FPXt9gPWAQg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:58:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUyGDrkhQy6FPXt9gPWAQg/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 16:58:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUyGDrkhQy6FPXt9gPWAQg/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 16:58:13 INFO - Downloaded 22700950 bytes. 16:58:13 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'] 16:58:13 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 16:58:14 INFO - Return code: 0 16:58:14 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 16:58:14 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')]} 16:58:14 INFO - https://queue.taskcluster.net/v1/task/NUyGDrkhQy6FPXt9gPWAQg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:58:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUyGDrkhQy6FPXt9gPWAQg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:58:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUyGDrkhQy6FPXt9gPWAQg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:58:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUyGDrkhQy6FPXt9gPWAQg/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 16:58:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUyGDrkhQy6FPXt9gPWAQg/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 16:58:16 INFO - Downloaded 22700950 bytes. 16:58:16 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'] 16:58:16 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 16:58:17 INFO - Return code: 0 16:58:17 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')]} 16:58:17 INFO - https://queue.taskcluster.net/v1/task/NUyGDrkhQy6FPXt9gPWAQg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:58:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUyGDrkhQy6FPXt9gPWAQg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:58:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUyGDrkhQy6FPXt9gPWAQg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:58:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUyGDrkhQy6FPXt9gPWAQg/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 16:58:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUyGDrkhQy6FPXt9gPWAQg/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 16:58:18 INFO - Downloaded 14403317 bytes. 16:58:18 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'] 16:58:18 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 16:58:18 INFO - Return code: 0 16:58:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:18 INFO - https://queue.taskcluster.net/v1/task/NUyGDrkhQy6FPXt9gPWAQg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:58:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUyGDrkhQy6FPXt9gPWAQg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:58:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUyGDrkhQy6FPXt9gPWAQg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:58:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUyGDrkhQy6FPXt9gPWAQg/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 16:58:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUyGDrkhQy6FPXt9gPWAQg/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 16:58:20 INFO - Downloaded 57004593 bytes. 16:58:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NUyGDrkhQy6FPXt9gPWAQg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:58:20 INFO - mkdir: /builds/slave/test/properties 16:58:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:58:20 INFO - Writing to file /builds/slave/test/properties/build_url 16:58:20 INFO - Contents: 16:58:20 INFO - build_url:https://queue.taskcluster.net/v1/task/NUyGDrkhQy6FPXt9gPWAQg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:58:21 INFO - Running post-action listener: _resource_record_post_action 16:58:21 INFO - Running post-action listener: set_extra_try_arguments 16:58:21 INFO - ##### 16:58:21 INFO - ##### Finished download-and-extract step (success) 16:58:21 INFO - ##### 16:58:21 INFO - ##### 16:58:21 INFO - ##### Running populate-webroot step. 16:58:21 INFO - ##### 16:58:21 INFO - Running pre-action listener: _resource_record_pre_action 16:58:21 INFO - Running main action method: populate_webroot 16:58:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:58:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:58:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:58:21 INFO - '--tppagecycles', 16:58:21 INFO - '7'], 16:58:21 INFO - 'tests': ['tsvgm']}}, 16:58:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:58:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:58:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:58:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:58:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:58:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:58:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:58:21 INFO - 'talos_options': ['--disable-e10s'], 16:58:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:58:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:58:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:58:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:58:21 INFO - 'talos_options': ['--disable-e10s'], 16:58:21 INFO - 'tests': ['damp', 'tps']}, 16:58:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:58:21 INFO - 'tests': ['damp', 'tps']}, 16:58:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:58:21 INFO - 'tests': ['dromaeo_dom']}, 16:58:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:58:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:58:21 INFO - 'tests': ['basic_compositor_video']}, 16:58:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:58:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:58:21 INFO - 'tests': ['a11yr', 16:58:21 INFO - 'ts_paint', 16:58:21 INFO - 'tpaint', 16:58:21 INFO - 'sessionrestore', 16:58:21 INFO - 'sessionrestore_no_auto_restore', 16:58:21 INFO - 'tabpaint']}, 16:58:21 INFO - 'other-e10s': {'tests': ['a11yr', 16:58:21 INFO - 'ts_paint', 16:58:21 INFO - 'tpaint', 16:58:21 INFO - 'sessionrestore', 16:58:21 INFO - 'sessionrestore_no_auto_restore', 16:58:21 INFO - 'tabpaint']}, 16:58:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:58:21 INFO - 'ts_paint', 16:58:21 INFO - 'tpaint', 16:58:21 INFO - 'sessionrestore', 16:58:21 INFO - 'sessionrestore_no_auto_restore', 16:58:21 INFO - 'tabpaint']}, 16:58:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:58:21 INFO - 'ts_paint', 16:58:21 INFO - 'tpaint', 16:58:21 INFO - 'sessionrestore', 16:58:21 INFO - 'sessionrestore_no_auto_restore', 16:58:21 INFO - 'tabpaint']}, 16:58:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:58:21 INFO - 'tests': ['a11yr', 16:58:21 INFO - 'ts_paint', 16:58:21 INFO - 'tpaint', 16:58:21 INFO - 'sessionrestore', 16:58:21 INFO - 'sessionrestore_no_auto_restore', 16:58:21 INFO - 'tabpaint']}, 16:58:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:58:21 INFO - 'tests': ['a11yr', 16:58:21 INFO - 'ts_paint', 16:58:21 INFO - 'tpaint', 16:58:21 INFO - 'sessionrestore', 16:58:21 INFO - 'sessionrestore_no_auto_restore', 16:58:21 INFO - 'tabpaint']}, 16:58:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:58:21 INFO - 'tests': ['tsvgx', 16:58:21 INFO - 'tsvgr_opacity', 16:58:21 INFO - 'tart', 16:58:21 INFO - 'tscrollx', 16:58:21 INFO - 'cart']}, 16:58:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:58:21 INFO - 'tsvgr_opacity', 16:58:21 INFO - 'tart', 16:58:21 INFO - 'tscrollx', 16:58:21 INFO - 'cart']}, 16:58:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:58:21 INFO - 'talos_options': ['--disable-e10s'], 16:58:21 INFO - 'tests': ['tp5o']}, 16:58:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:58:21 INFO - 'tests': ['tp5o']}, 16:58:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:58:21 INFO - 'talos_options': ['--disable-e10s', 16:58:21 INFO - '--xperf_path', 16:58:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:58:21 INFO - 'tests': ['tp5n']}, 16:58:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:58:21 INFO - 'talos_options': ['--xperf_path', 16:58:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:58:21 INFO - 'tests': ['tp5n']}}, 16:58:21 INFO - 'talos.zip': {'path': '', 16:58:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:58:21 INFO - Running post-action listener: _resource_record_post_action 16:58:21 INFO - ##### 16:58:21 INFO - ##### Finished populate-webroot step (success) 16:58:21 INFO - ##### 16:58:21 INFO - ##### 16:58:21 INFO - ##### Running create-virtualenv step. 16:58:21 INFO - ##### 16:58:21 INFO - Running pre-action listener: _resource_record_pre_action 16:58:21 INFO - Running main action method: create_virtualenv 16:58:21 INFO - Creating virtualenv /builds/slave/test/build/venv 16:58:21 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 16:58:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:58:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:58:21 INFO - Using real prefix '/usr' 16:58:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:58:21 INFO - Installing distribute.............................................................................................................................................................................................done. 16:58:23 INFO - Installing pip.................done. 16:58:23 INFO - Return code: 0 16:58:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:58:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a35030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cf6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf43b0>, '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 0x2cf52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf5740>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1468367311.993454-570373406', '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 16:58:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:58:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:58:23 INFO - Using env: {'DISPLAY': ':0', 16:58:23 INFO - 'HOME': '/home/cltbld', 16:58:23 INFO - 'LANG': 'en_US.UTF-8', 16:58:23 INFO - 'LANGUAGE': 'en_US:en', 16:58:23 INFO - 'LOGNAME': 'cltbld', 16:58:23 INFO - 'MAIL': '/var/mail/cltbld', 16:58:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:23 INFO - 'MOZ_NO_REMOTE': '1', 16:58:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:23 INFO - 'NO_EM_RESTART': '1', 16:58:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:23 INFO - 'PWD': '/builds/slave/test', 16:58:23 INFO - 'SHELL': '/bin/bash', 16:58:23 INFO - 'SHLVL': '1', 16:58:23 INFO - 'TERM': 'linux', 16:58:23 INFO - 'TMOUT': '86400', 16:58:23 INFO - 'USER': 'cltbld', 16:58:23 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1468367311.993454-570373406', 16:58:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:23 INFO - '_': '/tools/buildbot/bin/python'} 16:58:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:24 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 16:58:24 INFO - Cleaning up... 16:58:24 INFO - Return code: 0 16:58:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:58:24 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')]} 16:58:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:24 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')]} 16:58:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:24 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 0x2a35030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cf6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf43b0>, '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 0x2cf52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf5740>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1468367311.993454-570373406', '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 16:58:24 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 16:58:24 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 16:58:24 INFO - Using env: {'DISPLAY': ':0', 16:58:24 INFO - 'HOME': '/home/cltbld', 16:58:24 INFO - 'LANG': 'en_US.UTF-8', 16:58:24 INFO - 'LANGUAGE': 'en_US:en', 16:58:24 INFO - 'LOGNAME': 'cltbld', 16:58:24 INFO - 'MAIL': '/var/mail/cltbld', 16:58:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:24 INFO - 'MOZ_NO_REMOTE': '1', 16:58:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:24 INFO - 'NO_EM_RESTART': '1', 16:58:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:24 INFO - 'PWD': '/builds/slave/test', 16:58:24 INFO - 'SHELL': '/bin/bash', 16:58:24 INFO - 'SHLVL': '1', 16:58:24 INFO - 'TERM': 'linux', 16:58:24 INFO - 'TMOUT': '86400', 16:58:24 INFO - 'USER': 'cltbld', 16:58:24 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1468367311.993454-570373406', 16:58:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:24 INFO - '_': '/tools/buildbot/bin/python'} 16:58:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:24 INFO - Downloading/unpacking psutil>=3.1.1 16:58:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:58:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:58:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:58:27 INFO - Installing collected packages: psutil 16:58:27 INFO - Running setup.py install for psutil 16:58:27 INFO - building 'psutil._psutil_linux' extension 16:58:27 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 16:58:28 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 16:58:28 INFO - building 'psutil._psutil_posix' extension 16:58:28 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 16:58:28 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 16:58:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:58:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:58:28 INFO - Successfully installed psutil 16:58:28 INFO - Cleaning up... 16:58:28 INFO - Return code: 0 16:58:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:58: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')]} 16:58:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58: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')]} 16:58:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:28 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 0x2a35030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cf6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf43b0>, '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 0x2cf52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf5740>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1468367311.993454-570373406', '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 16:58:28 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 16:58:28 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 16:58:28 INFO - Using env: {'DISPLAY': ':0', 16:58:28 INFO - 'HOME': '/home/cltbld', 16:58:28 INFO - 'LANG': 'en_US.UTF-8', 16:58:28 INFO - 'LANGUAGE': 'en_US:en', 16:58:28 INFO - 'LOGNAME': 'cltbld', 16:58:28 INFO - 'MAIL': '/var/mail/cltbld', 16:58:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:28 INFO - 'MOZ_NO_REMOTE': '1', 16:58:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:28 INFO - 'NO_EM_RESTART': '1', 16:58:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:28 INFO - 'PWD': '/builds/slave/test', 16:58:28 INFO - 'SHELL': '/bin/bash', 16:58:28 INFO - 'SHLVL': '1', 16:58:28 INFO - 'TERM': 'linux', 16:58:28 INFO - 'TMOUT': '86400', 16:58:28 INFO - 'USER': 'cltbld', 16:58:28 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1468367311.993454-570373406', 16:58:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:28 INFO - '_': '/tools/buildbot/bin/python'} 16:58:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:58:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:58:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:58:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:58:31 INFO - Installing collected packages: mozsystemmonitor 16:58:31 INFO - Running setup.py install for mozsystemmonitor 16:58:31 INFO - Successfully installed mozsystemmonitor 16:58:31 INFO - Cleaning up... 16:58:31 INFO - Return code: 0 16:58:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:58:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:31 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 0x2a35030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cf6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf43b0>, '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 0x2cf52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf5740>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1468367311.993454-570373406', '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 16:58:31 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 16:58:31 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 16:58:31 INFO - Using env: {'DISPLAY': ':0', 16:58:31 INFO - 'HOME': '/home/cltbld', 16:58:31 INFO - 'LANG': 'en_US.UTF-8', 16:58:31 INFO - 'LANGUAGE': 'en_US:en', 16:58:31 INFO - 'LOGNAME': 'cltbld', 16:58:31 INFO - 'MAIL': '/var/mail/cltbld', 16:58:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:31 INFO - 'MOZ_NO_REMOTE': '1', 16:58:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:31 INFO - 'NO_EM_RESTART': '1', 16:58:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:31 INFO - 'PWD': '/builds/slave/test', 16:58:31 INFO - 'SHELL': '/bin/bash', 16:58:31 INFO - 'SHLVL': '1', 16:58:31 INFO - 'TERM': 'linux', 16:58:31 INFO - 'TMOUT': '86400', 16:58:31 INFO - 'USER': 'cltbld', 16:58:31 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1468367311.993454-570373406', 16:58:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:31 INFO - '_': '/tools/buildbot/bin/python'} 16:58:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:31 INFO - Downloading/unpacking jsonschema==2.5.1 16:58:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:58:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:58:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:33 INFO - Downloading functools32-3.2.3-2.tar.gz 16:58:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:58:33 INFO - warning: no files found matching '*.txt' 16:58:33 INFO - no previously-included directories found matching 'build' 16:58:33 INFO - no previously-included directories found matching 'dist' 16:58:33 INFO - no previously-included directories found matching '.git*' 16:58:33 INFO - Installing collected packages: jsonschema, functools32 16:58:33 INFO - Running setup.py install for functools32 16:58:33 INFO - warning: no files found matching '*.txt' 16:58:33 INFO - no previously-included directories found matching 'build' 16:58:33 INFO - no previously-included directories found matching 'dist' 16:58:33 INFO - no previously-included directories found matching '.git*' 16:58:33 INFO - Successfully installed jsonschema functools32 16:58:33 INFO - Cleaning up... 16:58:33 INFO - Return code: 0 16:58:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:58:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:33 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 0x2a35030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cf6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf43b0>, '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 0x2cf52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf5740>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1468367311.993454-570373406', '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 16:58:33 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 16:58:33 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 16:58:33 INFO - Using env: {'DISPLAY': ':0', 16:58:33 INFO - 'HOME': '/home/cltbld', 16:58:33 INFO - 'LANG': 'en_US.UTF-8', 16:58:33 INFO - 'LANGUAGE': 'en_US:en', 16:58:33 INFO - 'LOGNAME': 'cltbld', 16:58:33 INFO - 'MAIL': '/var/mail/cltbld', 16:58:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:33 INFO - 'MOZ_NO_REMOTE': '1', 16:58:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:33 INFO - 'NO_EM_RESTART': '1', 16:58:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:33 INFO - 'PWD': '/builds/slave/test', 16:58:33 INFO - 'SHELL': '/bin/bash', 16:58:33 INFO - 'SHLVL': '1', 16:58:33 INFO - 'TERM': 'linux', 16:58:33 INFO - 'TMOUT': '86400', 16:58:33 INFO - 'USER': 'cltbld', 16:58:33 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1468367311.993454-570373406', 16:58:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:33 INFO - '_': '/tools/buildbot/bin/python'} 16:58:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:34 INFO - Downloading/unpacking blobuploader==1.2.4 16:58:34 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 16:58:34 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 16:58:34 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 16:58:34 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 16:58:34 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 16:58:34 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 16:58:36 INFO - Downloading blobuploader-1.2.4.tar.gz 16:58:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:58:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:58:36 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 16:58:36 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 16:58:36 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 16:58:36 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 16:58:36 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 16:58:36 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 16:58:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:58:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:58:36 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 16:58:36 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 16:58:36 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 16:58:36 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 16:58:36 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 16:58:36 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 16:58:36 INFO - Downloading docopt-0.6.1.tar.gz 16:58:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:58:36 INFO - Installing collected packages: blobuploader, requests, docopt 16:58:36 INFO - Running setup.py install for blobuploader 16:58:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:58:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:58:36 INFO - Running setup.py install for requests 16:58:37 INFO - Running setup.py install for docopt 16:58:37 INFO - Successfully installed blobuploader requests docopt 16:58:37 INFO - Cleaning up... 16:58:37 INFO - Return code: 0 16:58:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:58:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:37 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 0x2a35030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cf6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf43b0>, '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 0x2cf52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf5740>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1468367311.993454-570373406', '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 16:58:37 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 16:58:37 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 16:58:37 INFO - Using env: {'DISPLAY': ':0', 16:58:37 INFO - 'HOME': '/home/cltbld', 16:58:37 INFO - 'LANG': 'en_US.UTF-8', 16:58:37 INFO - 'LANGUAGE': 'en_US:en', 16:58:37 INFO - 'LOGNAME': 'cltbld', 16:58:37 INFO - 'MAIL': '/var/mail/cltbld', 16:58:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:37 INFO - 'MOZ_NO_REMOTE': '1', 16:58:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:37 INFO - 'NO_EM_RESTART': '1', 16:58:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:37 INFO - 'PWD': '/builds/slave/test', 16:58:37 INFO - 'SHELL': '/bin/bash', 16:58:37 INFO - 'SHLVL': '1', 16:58:37 INFO - 'TERM': 'linux', 16:58:37 INFO - 'TMOUT': '86400', 16:58:37 INFO - 'USER': 'cltbld', 16:58:37 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1468367311.993454-570373406', 16:58:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:37 INFO - '_': '/tools/buildbot/bin/python'} 16:58:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:58:37 INFO - Running setup.py (path:/tmp/pip-iTjlYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:58:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:58:37 INFO - Running setup.py (path:/tmp/pip-T8ateh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:58:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:58:37 INFO - Running setup.py (path:/tmp/pip-XbxD8f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:58:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:58:37 INFO - Running setup.py (path:/tmp/pip-4ANJ2Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:58:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:58:37 INFO - Running setup.py (path:/tmp/pip-7YSc38-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:58:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:58:38 INFO - Running setup.py (path:/tmp/pip-9tMo4S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:58:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:58:38 INFO - Running setup.py (path:/tmp/pip-BnN6O0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:58:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:58:38 INFO - Running setup.py (path:/tmp/pip-7x5eDG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:58:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:58:38 INFO - Running setup.py (path:/tmp/pip-dBNIp5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:58:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:58:38 INFO - Running setup.py (path:/tmp/pip-rIAkl1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:58:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:58:38 INFO - Running setup.py (path:/tmp/pip-hYEZau-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:58:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:58:38 INFO - Running setup.py (path:/tmp/pip-sS9vjs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:58:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:58:38 INFO - Running setup.py (path:/tmp/pip-L5lrKf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:58:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:58:38 INFO - Running setup.py (path:/tmp/pip-LS6ABg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:58:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:58:38 INFO - Running setup.py (path:/tmp/pip-xkCqVL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:58:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:58:38 INFO - Running setup.py (path:/tmp/pip-DHbsaH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:58:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:58:38 INFO - Running setup.py (path:/tmp/pip-28TWIw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:58:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:58:38 INFO - Running setup.py install for manifestparser 16:58:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:58:38 INFO - Running setup.py install for mozcrash 16:58:39 INFO - Running setup.py install for mozdebug 16:58:39 INFO - Running setup.py install for mozdevice 16:58:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:58:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:58:39 INFO - Running setup.py install for mozfile 16:58:39 INFO - Running setup.py install for mozhttpd 16:58:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:58:39 INFO - Running setup.py install for mozinfo 16:58:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:58:39 INFO - Running setup.py install for mozInstall 16:58:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:58:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:58:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:58:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:58:39 INFO - Running setup.py install for mozleak 16:58:39 INFO - Running setup.py install for mozlog 16:58:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:58:39 INFO - Running setup.py install for moznetwork 16:58:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:58:40 INFO - Running setup.py install for mozprocess 16:58:40 INFO - Running setup.py install for mozprofile 16:58:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:58:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:58:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:58:40 INFO - Running setup.py install for mozrunner 16:58:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:58:40 INFO - Running setup.py install for mozscreenshot 16:58:40 INFO - Running setup.py install for moztest 16:58:40 INFO - Running setup.py install for mozversion 16:58:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:58:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:58:40 INFO - Cleaning up... 16:58:40 INFO - Return code: 0 16:58:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:58: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')]} 16:58:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58: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')]} 16:58:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:40 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 0x2a35030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cf6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf43b0>, '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 0x2cf52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf5740>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1468367311.993454-570373406', '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 16:58:40 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 16:58:40 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 16:58:40 INFO - Using env: {'DISPLAY': ':0', 16:58:40 INFO - 'HOME': '/home/cltbld', 16:58:40 INFO - 'LANG': 'en_US.UTF-8', 16:58:40 INFO - 'LANGUAGE': 'en_US:en', 16:58:40 INFO - 'LOGNAME': 'cltbld', 16:58:40 INFO - 'MAIL': '/var/mail/cltbld', 16:58:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:40 INFO - 'MOZ_NO_REMOTE': '1', 16:58:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:40 INFO - 'NO_EM_RESTART': '1', 16:58:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:40 INFO - 'PWD': '/builds/slave/test', 16:58:40 INFO - 'SHELL': '/bin/bash', 16:58:40 INFO - 'SHLVL': '1', 16:58:40 INFO - 'TERM': 'linux', 16:58:40 INFO - 'TMOUT': '86400', 16:58:40 INFO - 'USER': 'cltbld', 16:58:40 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1468367311.993454-570373406', 16:58:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:40 INFO - '_': '/tools/buildbot/bin/python'} 16:58:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:58:40 INFO - Running setup.py (path:/tmp/pip-gqzyn5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:58:40 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)) 16:58:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:58:40 INFO - Running setup.py (path:/tmp/pip-aKkEcp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:58:41 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)) 16:58:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:58:41 INFO - Running setup.py (path:/tmp/pip-s9XII1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:58:41 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)) 16:58:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:58:41 INFO - Running setup.py (path:/tmp/pip-IE6GLZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:58:41 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)) 16:58:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:58:41 INFO - Running setup.py (path:/tmp/pip-pWli5D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:58:41 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)) 16:58:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:58:41 INFO - Running setup.py (path:/tmp/pip-BcoIE7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:58:41 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)) 16:58:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:58:41 INFO - Running setup.py (path:/tmp/pip-V0crkx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:58:41 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)) 16:58:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:58:41 INFO - Running setup.py (path:/tmp/pip-1ecwxM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:58:41 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)) 16:58:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:58:41 INFO - Running setup.py (path:/tmp/pip-jHKEWk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:58:41 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)) 16:58:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:58:41 INFO - Running setup.py (path:/tmp/pip-f3SfBD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:58:41 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)) 16:58:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:58:41 INFO - Running setup.py (path:/tmp/pip-LliBOY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:58:41 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)) 16:58:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:58:41 INFO - Running setup.py (path:/tmp/pip-YIOX_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:58:41 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)) 16:58:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:58:41 INFO - Running setup.py (path:/tmp/pip-9DNQPp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:58:41 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)) 16:58:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:58:41 INFO - Running setup.py (path:/tmp/pip-vNYNzt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:58:41 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)) 16:58:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:58:41 INFO - Running setup.py (path:/tmp/pip-wQ0qis-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:58:41 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)) 16:58:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:58:41 INFO - Running setup.py (path:/tmp/pip-dd4SA2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:58:42 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)) 16:58:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:58:42 INFO - Running setup.py (path:/tmp/pip-oz9q_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:58:42 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)) 16:58:42 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)) 16:58:42 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)) 16:58:42 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)) 16:58:42 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)) 16:58:42 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)) 16:58:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:58:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:44 INFO - Downloading blessings-1.6.tar.gz 16:58:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:58:44 INFO - Installing collected packages: blessings 16:58:44 INFO - Running setup.py install for blessings 16:58:44 INFO - Successfully installed blessings 16:58:44 INFO - Cleaning up... 16:58:44 INFO - Return code: 0 16:58:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:58:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:58:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:58:44 INFO - Reading from file tmpfile_stdout 16:58:44 INFO - Current package versions: 16:58:44 INFO - argparse == 1.2.1 16:58:44 INFO - blessings == 1.6 16:58:44 INFO - blobuploader == 1.2.4 16:58:44 INFO - docopt == 0.6.1 16:58:44 INFO - functools32 == 3.2.3-2 16:58:44 INFO - jsonschema == 2.5.1 16:58:44 INFO - manifestparser == 1.1 16:58:44 INFO - mozInstall == 1.12 16:58:44 INFO - mozcrash == 0.17 16:58:44 INFO - mozdebug == 0.1 16:58:44 INFO - mozdevice == 0.48 16:58:44 INFO - mozfile == 1.2 16:58:44 INFO - mozhttpd == 0.7 16:58:44 INFO - mozinfo == 0.9 16:58:44 INFO - mozleak == 0.1 16:58:44 INFO - mozlog == 3.2 16:58:44 INFO - moznetwork == 0.27 16:58:44 INFO - mozprocess == 0.23 16:58:44 INFO - mozprofile == 0.28 16:58:44 INFO - mozrunner == 6.12 16:58:44 INFO - mozscreenshot == 0.1 16:58:44 INFO - mozsystemmonitor == 0.3 16:58:44 INFO - moztest == 0.7 16:58:44 INFO - mozversion == 1.4 16:58:44 INFO - psutil == 3.1.1 16:58:44 INFO - requests == 1.2.3 16:58:44 INFO - wsgiref == 0.1.2 16:58:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:58:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:44 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 0x2a35030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cf6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf43b0>, '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 0x2cf52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf5740>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1468367311.993454-570373406', '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 16:58:44 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 16:58:44 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 16:58:44 INFO - Using env: {'DISPLAY': ':0', 16:58:44 INFO - 'HOME': '/home/cltbld', 16:58:44 INFO - 'LANG': 'en_US.UTF-8', 16:58:44 INFO - 'LANGUAGE': 'en_US:en', 16:58:44 INFO - 'LOGNAME': 'cltbld', 16:58:44 INFO - 'MAIL': '/var/mail/cltbld', 16:58:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:44 INFO - 'MOZ_NO_REMOTE': '1', 16:58:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:44 INFO - 'NO_EM_RESTART': '1', 16:58:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:44 INFO - 'PWD': '/builds/slave/test', 16:58:44 INFO - 'SHELL': '/bin/bash', 16:58:44 INFO - 'SHLVL': '1', 16:58:44 INFO - 'TERM': 'linux', 16:58:44 INFO - 'TMOUT': '86400', 16:58:44 INFO - 'USER': 'cltbld', 16:58:44 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1468367311.993454-570373406', 16:58:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:44 INFO - '_': '/tools/buildbot/bin/python'} 16:58:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:44 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)) 16:58:44 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)) 16:58:44 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)) 16:58:44 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)) 16:58:44 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)) 16:58:44 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)) 16:58:44 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)) 16:58:44 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)) 16:58:44 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)) 16:58:44 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)) 16:58:44 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)) 16:58:44 INFO - Cleaning up... 16:58:44 INFO - Return code: 0 16:58:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:58:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:44 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 0x2a35030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cf6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf43b0>, '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 0x2cf52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf5740>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1468367311.993454-570373406', '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 16:58:44 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 16:58:44 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 16:58:44 INFO - Using env: {'DISPLAY': ':0', 16:58:44 INFO - 'HOME': '/home/cltbld', 16:58:44 INFO - 'LANG': 'en_US.UTF-8', 16:58:44 INFO - 'LANGUAGE': 'en_US:en', 16:58:44 INFO - 'LOGNAME': 'cltbld', 16:58:44 INFO - 'MAIL': '/var/mail/cltbld', 16:58:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:44 INFO - 'MOZ_NO_REMOTE': '1', 16:58:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:44 INFO - 'NO_EM_RESTART': '1', 16:58:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:44 INFO - 'PWD': '/builds/slave/test', 16:58:44 INFO - 'SHELL': '/bin/bash', 16:58:44 INFO - 'SHLVL': '1', 16:58:44 INFO - 'TERM': 'linux', 16:58:44 INFO - 'TMOUT': '86400', 16:58:44 INFO - 'USER': 'cltbld', 16:58:44 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1468367311.993454-570373406', 16:58:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:44 INFO - '_': '/tools/buildbot/bin/python'} 16:58:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:58:44 INFO - Cleaning up... 16:58:44 INFO - Return code: 0 16:58:44 INFO - Running post-action listener: _resource_record_post_action 16:58:44 INFO - Running post-action listener: _start_resource_monitoring 16:58:45 INFO - Starting resource monitoring. 16:58:45 INFO - ##### 16:58:45 INFO - ##### Finished create-virtualenv step (success) 16:58:45 INFO - ##### 16:58:45 INFO - ##### 16:58:45 INFO - ##### Running install step. 16:58:45 INFO - ##### 16:58:45 INFO - Running pre-action listener: _resource_record_pre_action 16:58:45 INFO - Running main action method: install 16:58:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:58:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:58:45 INFO - Reading from file tmpfile_stdout 16:58:45 INFO - Detecting whether we're running mozinstall >=1.0... 16:58:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:58:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:58:45 INFO - Reading from file tmpfile_stdout 16:58:45 INFO - Output received: 16:58:45 INFO - Usage: mozinstall [options] installer 16:58:45 INFO - Options: 16:58:45 INFO - -h, --help show this help message and exit 16:58:45 INFO - -d DEST, --destination=DEST 16:58:45 INFO - Directory to install application into. [default: 16:58:45 INFO - "/builds/slave/test"] 16:58:45 INFO - --app=APP Application being installed. [default: firefox] 16:58:45 INFO - mkdir: /builds/slave/test/build/application 16:58:45 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'] 16:58:45 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 16:59:01 INFO - Reading from file tmpfile_stdout 16:59:01 INFO - Output received: 16:59:01 INFO - /builds/slave/test/build/application/firefox/firefox 16:59:01 INFO - Running post-action listener: _resource_record_post_action 16:59:01 INFO - ##### 16:59:01 INFO - ##### Finished install step (success) 16:59:01 INFO - ##### 16:59:01 INFO - ##### 16:59:01 INFO - ##### Running run-tests step. 16:59:01 INFO - ##### 16:59:01 INFO - Running pre-action listener: _resource_record_pre_action 16:59:01 INFO - Running main action method: run_tests 16:59:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:59:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:59:01 INFO - Python 2.7.3 16:59:01 INFO - Return code: 0 16:59:01 INFO - grabbing minidump binary from tooltool 16:59:01 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')]} 16:59:01 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 0x2cf43b0>, '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 0x2cf52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf5740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:59:01 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 16:59:01 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 16:59:01 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 16:59:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:59:01 INFO - Return code: 0 16:59:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:59:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:59:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:59:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:59:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:59:01 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/NUyGDrkhQy6FPXt9gPWAQg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 16:59:01 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/NUyGDrkhQy6FPXt9gPWAQg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --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 16:59:01 INFO - Using env: {'DISPLAY': ':0', 16:59:01 INFO - 'HOME': '/home/cltbld', 16:59:01 INFO - 'LANG': 'en_US.UTF-8', 16:59:01 INFO - 'LANGUAGE': 'en_US:en', 16:59:01 INFO - 'LOGNAME': 'cltbld', 16:59:01 INFO - 'MAIL': '/var/mail/cltbld', 16:59:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:59:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:59:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:01 INFO - 'MOZ_NO_REMOTE': '1', 16:59:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:59:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:59:01 INFO - 'NO_EM_RESTART': '1', 16:59:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:59:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:59:01 INFO - 'PWD': '/builds/slave/test', 16:59:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:59:01 INFO - 'SHELL': '/bin/bash', 16:59:01 INFO - 'SHLVL': '1', 16:59:01 INFO - 'TERM': 'linux', 16:59:01 INFO - 'TMOUT': '86400', 16:59:01 INFO - 'USER': 'cltbld', 16:59:01 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1468367311.993454-570373406', 16:59:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:01 INFO - '_': '/tools/buildbot/bin/python'} 16:59:01 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/NUyGDrkhQy6FPXt9gPWAQg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 16:59:02 INFO - mozversion application_buildid: 20160712152526 16:59:02 INFO - mozversion application_changeset: 53947432322b06f80b079fef73e43d7e6785f81b 16:59:02 INFO - mozversion application_display_name: Nightly 16:59:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:59:02 INFO - mozversion application_name: Firefox 16:59:02 INFO - mozversion application_remotingname: firefox 16:59:02 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:59:02 INFO - mozversion application_vendor: Mozilla 16:59:02 INFO - mozversion application_version: 50.0a1 16:59:02 INFO - mozversion platform_buildid: 20160712152526 16:59:02 INFO - mozversion platform_changeset: 53947432322b06f80b079fef73e43d7e6785f81b 16:59:02 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:59:02 INFO - mozversion platform_version: 50.0a1 16:59:02 INFO - using testdate: 1468367942 16:59:02 INFO - actual date: 1468367942 16:59:02 INFO - starting webserver on 'localhost:39004' 16:59:02 INFO - SUITE-START | Running 2 tests 16:59:02 INFO - TEST-START | dromaeo_css 16:59:02 INFO - operating with platform_type : linux_ 16:59:02 INFO - Initialising browser for dromaeo_css test... 16:59:02 INFO - TEST-INFO | started process 3328 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuTKND6/profile http://localhost:39004/getInfo.html) 16:59:07 INFO - PROCESS | 3328 | __metrics Screen width/height:1600/1200 16:59:07 INFO - PROCESS | 3328 | colorDepth:24 16:59:07 INFO - PROCESS | 3328 | Browser inner width/height: 1024/697 16:59:07 INFO - PROCESS | 3328 | __metrics 16:59:08 INFO - PROCESS | 3328 | 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" 16:59:08 INFO - PROCESS | 3328 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:59:09 INFO - TEST-INFO | 3328: exit 0 16:59:09 INFO - Browser initialized. 16:59:09 INFO - Running cycle 1/1 for dromaeo_css test... 16:59:09 INFO - TEST-INFO | started process 3409 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuTKND6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:59:21 INFO - PROCESS | 3409 | RSS: Main: 158904320 16:59:21 INFO - PROCESS | 3409 | 17:00:12 INFO - PROCESS | 3409 | 1468368012530 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] 17:02:25 INFO - PROCESS | 3409 | Cycle 1(1): loaded http://localhost:39004/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39004/tests/dromaeo/cssquery-ext.html) 17:02:26 INFO - PROCESS | 3409 | RSS: Main: 265404416 17:02:26 INFO - PROCESS | 3409 | 17:05:29 INFO - PROCESS | 3409 | Cycle 1(1): loaded http://localhost:39004/tests/dromaeo/cssquery-ext.html (next: http://localhost:39004/tests/dromaeo/cssquery-jquery.html) 17:05:30 INFO - PROCESS | 3409 | RSS: Main: 246583296 17:05:30 INFO - PROCESS | 3409 | 17:08:32 INFO - PROCESS | 3409 | Cycle 1(1): loaded http://localhost:39004/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39004/tests/dromaeo/cssquery-mootools.html) 17:08:32 INFO - PROCESS | 3409 | RSS: Main: 244776960 17:08:32 INFO - PROCESS | 3409 | 17:11:34 INFO - PROCESS | 3409 | Cycle 1(1): loaded http://localhost:39004/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39004/tests/dromaeo/cssquery-prototype.html) 17:11:35 INFO - PROCESS | 3409 | RSS: Main: 241209344 17:11:35 INFO - PROCESS | 3409 | 17:14:38 INFO - PROCESS | 3409 | Cycle 1(1): loaded http://localhost:39004/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39004/tests/dromaeo/cssquery-yui.html) 17:14:39 INFO - PROCESS | 3409 | RSS: Main: 224477184 17:14:39 INFO - PROCESS | 3409 | 17:17:42 INFO - PROCESS | 3409 | Cycle 1(1): loaded http://localhost:39004/tests/dromaeo/cssquery-yui.html (next: http://localhost:39004/tests/dromaeo/cssquery-dojo.html) 17:17:42 INFO - PROCESS | 3409 | RSS: Main: 266186752 17:17:42 INFO - PROCESS | 3409 | 17:17:42 INFO - PROCESS | 3409 | __start_tp_report 17:17:42 INFO - PROCESS | 3409 | _x_x_mozilla_page_load 17:17:42 INFO - PROCESS | 3409 | _x_x_mozilla_page_load_details 17:17:42 INFO - PROCESS | 3409 | |i|pagename|runs| 17:17:42 INFO - PROCESS | 3409 | |0;dojo.html;2564.8717564121794;2583.237944806282;2603.1799983005353;2610.5301045811757;2611.1774790940854;4470.128324976631;4540.70485418448;4559.452865656126;4575.1764682357125;4588.151192029472;4592.72443653381;4611.469680986687;4625.468071171807;4659.767011649413;4661.953380466202;4018.5177778666603;4156.5635608261155;4260.850870219543;4285.378620100084;4359.171757366106;4267.1892340455215;4337.371081193225;4340.02349471368;4346.195953748566;4369.3227549729845;4144.606262405082;4181.60274773896;4204.138151678929;4209.7474151551005;4224.176285624305;4181.895452613679;4189.036521600018;4189.853355132555;4264.04059086703;4296.441462609872;4284.528701842794;4295.8281668733525;4312.439382880237;4339.6528277738025;4350.782460876975;4484.8206071757095;4563.452385713703;4598.103369842882;4686.718796872198;4709.95290047102;4936.6050715943;4936.679115857458;4960.23116416956;4968.701877887338;4973.030259099477;4988.82539111133;5006.249062640633;5018.698878067327;5021.096202683516;5021.44764075955;4500.122476117126;4615.26155815068;4669.2062349400685;4680.765961701902;4698.4361876574685;5140.563052140536;5152.6650767699975;5158.484151584887;5161.716105614152;5166.844994650167;4902.117618828645;4939.629527785431;4955.8513244602;4957.7273249971595;4959.975200124049;4813.7352445615825;4900.877478063006;4940.456549779521;4967.155583550805;5014.373203349582;4893.884632784675;4899.755012249373;4908.067467181224;4909.361782968192;4942.308076869242;4884.169691152512;4886.144924638245;4886.828960986349;4924.482929292444;4939.827106051271;4060.614241647039;4089.89775255621;4109.4246805447265;4149.107941792468;4178.080822219168;3626.220362622049;3646.1796095878744;3669.3395188865725;3673.540807399075;3706.9814650926573;4298.075913678574;4301.849435269751;4307.267764480046;4307.461567304087;4351.912961740811;4765.523447655207;4834.444038935497;4860.441049279308;4870.172070747982;4956.231784073474;4256.106217694257;4279.87160385189;4280.464941882265;4284.871453856389;4318.179545886334;4381.846635367747;4405.493368262627;4408.625266852289;4432.268675668479;4435.977820110943;4612.446506419184;4646.488886222445;4722.126406614787;4727.361806156263;4760.428748550196;4953.702777833341;4954.925676114934;4956.132676781477;4970.527799859007;4988.376452943382;4733.148033354029;4733.266343716729;4733.479317275166;4744.3357929890535;4795.352627395257;4668.136394766979;4803.279508073817;4834.178189707828;4853.975730121468;4881.707097574157;4907.484714104968;4929.408470983505;4935.580475659609;4942.233953737176;4980.352554167935;4673;4797.136515427256;4802.447718512416;4815.662903596714;4859.441164266154;4802.8799280018275;4845.127876982177;4850.981293928315;4863.294822250683;4882.438519570295;4773.236282194832;4805.37530121096;4821.421429428491;4854.75726213695;4862.100511405401;4703.623710103115;4730.385049943486;4912.606991440748;4915.066137433876;4948.727819969936;4675.205215113507;4687.1328804171335;4690.249560070372;4715.151272770934;4760.190767569452 17:17:42 INFO - PROCESS | 3409 | |1;ext.html;572.4504475703325;573.1145380387301;581.8399940016492;585.9794907178247;587.0636335045604;27424.86287568562;29849.9552515662;29965.400691986146;40341.39487907684;41673;42473.36289955646;42958.57041429593;42976.35535466971;43034.35448468276;43051.35422968658;7847.646855891484;7950.721724739636;7957.283844453998;7964.323032542241;7995.320397766197;7514.135874374462;7862.292393684567;10074.748131296703;10349.793004139912;10355.27513074085;10349.689509314732;10400.47997600117;10419;10423.68728938133;10433;7672.3478504327195;10296.14669359515;10341.276110672256;10360.792784144274;10369.222308326867;9907.108360247612;10310.536025878779;10323.174146068297;10646.095081918047;10661.147108231324;39446;39594.20811583781;39756.801215993735;39761.80119099415;39779;3073.8770449182007;3081.4607443697264;3361.344537815127;3588.4079126944025;3747.4940882980723;29846.403071938657;29979.25051873699;30437.543436848464;30462.54306185409;31413.37173256522;3514.121469632592;3518.6305437928904;3530.593981692087;3537.8584856605703;3618.7285953553587;267190;267294;267412;267491;267857;54575;55051.724741376034;55098.17352739712;55143.72428137834;55196.17205741917;33392;34302.313953721285;34441;36398.09004774902;36420.45369319462;15997.28012239452;16099.275532601061;16145.192740362934;16164.838351616334;16201.675966480605;10991.890081099087;11762.235454695418;12040.277583345027;12106.273623582612;12121.696957575954;18141.7278740819;18851.151698173617;18877.52806179829;18920.33778817762;18943.715844262348;6763.5941843489545;6865.828354291183;6873.175218973755;6942;6974.152854328754;801.4189712458538;884.1467983396054;987.1017374189453;1017.5115944346755;1025.4616326428536;27880.72119278822;28705.28236794097;28707;28859;29218;975.3032864130685;975.4293738163112;984.3503287829998;994.4033579852031;1053.5680371047833;15226.543203703906;15236;15424.997375170578;15571.299291531908;15721.68556628861;379259;382231;382352;385023.82368969417;385400;49587;50155;50160.247596286084;50321;50355;1068.4283908109123;1123.0678536814587;1127.81954887216;1164.2490593567102;1205.7046023724245;19421.924920127683;29312;29517.852410737807;31243.375132496767;31454.52818207683;46915.296270555285;47515.52484475111;47525.04949900913;47547;47652.2852157211;337462;344017;344132;344320;345734;22419.551608968057;22929.197478088186;24843;25514.362140946625;25571.74428255768;42432;42498.36252456154;42591.7870410646;42643.147137057706;43248.783756081015;36373.818130909174;36696.08259793527;36779.81610091932;37157.03791939668;37251.44122838105;36972.63027369799;37502.81248593739;37541;37695.81152094222;37951.81024094862;34344.48483272703;34627.30745385129;35205;35229.82385088058;35375.29249415049;31627.367452650356;32688.127318012634;32942.67057329396;33335.66664333326;33583.481238906694;24952.875235623706;24955.50088998246;25273;25480.8725956369;25790.484190316463 17:17:42 INFO - PROCESS | 3409 | |2;jquery.html;356.5151394104017;358.87618771523813;371.9330520506309;372.4115896882925;393.0645064745904;17342.739858902125;17362.82637173628;18326.541836454096;18333.17500712468;18350.449486515427;15855.286512106954;16243.187840607981;16288.185590720446;16502.17489125545;16541;5102.846914592559;5274.156135018397;5308.814191503298;5319.095753721857;5319.760610772524;3863.2273545290914;4053.716239863211;5239.580833533309;6055.424734650202;6367.936320636803;6375.808725738212;6408.551401401904;6408.839779005515;6437.806865794034;6444.967775161118;5370.677759334452;5655.632383895034;5663.0655941769555;5741.569382296345;5753.338366087912;3382.96617033829;5037.974810125926;5333.573314134898;5350.224217488442;5564;12306.938465307705;12483.812742808865;12501.687457813627;14469.348879300456;20803.895980520152;1900.1734245603068;1945.8540609454349;2102.905369258387;2139.529303553216;2401.368800111409;8912.8663070054;9335.813283734287;9859.802803943952;10417.583296668125;13967.511137110254;1536.9692606147926;1750.3523696232348;1760.5598600349913;1787.30295184878;1849.824266694662;69260.6536967317;71087.28912710858;72051;72118.99999999948;72591.63704181445;10162.898371016343;10238.283320167517;10323.122534584494;10654.840177397346;10895.727606809893;13912.721745565032;14026.08830426019;14029.579112626638;14029.649258768612;14031.438742450187;7250.383717383976;7260.6732697028765;7277.745278915212;7324.816879577947;7481.102267727799;6819;6929.1684997799575;7011.088558487466;7013.333733295329;7016.719331226694;4426.9778651106535;4462.531434199363;4509.436320459942;4510.954890451119;4562.224421848294;1627.5524230836616;1718.218210714122;1727.7494763259508;1736.3401907275154;1796.1917137288012;714.6241313960867;853.2363534636589;862.4480332587149;870.1776820904184;899.6311512279934;17150;17286.740698889527;17699.646007079788;17782.733259001125;18100.27598896056;874.3879284500874;877.3288434347729;893.8301722672671;909.4543274035658;924.9732796595773;9603.183729382941;9673.806523869483;9973.451460169761;10207.183425325957;10461.110805581611;276315;281041;283108;387603;399704;77504;81528;81608.59195703984;84493.57753211194;85816;926.7405126564438;952.1097773581723;974.8294048541619;979.4172467381896;979.9559019844124;16172;16432.342706291616;16436;16565.91717041407;17010.914945425688;39069;39073.41389879211;39084.413733793444;39844.40233396559;39961.60038399695;48452.273215901085;52553.21170182374;54015;54287.72856135694;54642;7062.788116356517;7100.644967751695;7370.557766534025;7413.962930185315;7437.367823735043;9839.85240221383;10067.848982265125;10342.586296548054;10713.35719856811;11115.22193446451;4615.953840461552;4738.763061846825;6380.72385522888;9338.766530836783;9443.905560944302;9021.729348119567;9268.768280793034;9319.487428191514;9356.06439356059;9769;9702.272329575451;9784.364016338915;10019.849702254327;10033.598656053677;10170.135538479017;7288.416926645961;7318.597477138808;7402.703891844266;7419.406447484296;7423.777286681408;7831.647575859214;9568.856467153137;9759.707208783748;9889.608068935324;10037.247206459399 17:17:42 INFO - PROCESS | 3409 | |3;mootools.html;1202.7895118354288;1249.7125661097948;1323.02096448628;1675.279629759203;1689.020368186452;7034.824129396761;7380.114386273648;7458.366038886701;7472.290132437416;7485.850282994337;6408.487321014308;7016.368526832597;7163.749268775581;7220.350168484835;7487.3635740961945;2168.2086038595917;2193.462601662595;2197.4176843136584;2199.3731786440867;2200.7689192634784;2091.3307741522717;2128.5636444528914;2188.157559339658;2189.386971647933;2190.7480639726396;1843.1060935446365;2124.468882779305;2192.3094225318973;2196.286206982729;2221.244776775896;2172.1637169689784;2178.9019494122804;2196.417949243452;2200.6698995150778;2204.9559008819892;2133.9466513337134;2142.989285053565;2144.8069673729283;2145.753238377591;2146.6994620753107;7323.267673232687;7395.075615548057;7418.666160022812;7431.554106753612;7435.293647103516;4403.493598236212;4541.591256786905;4544.522825103382;4548.727076375395;4548.7725613719185;2798.510260704389;2854.8572571371346;2953.394554116401;2960.1119664100897;2961.1708721557998;877.2674816528206;879.2614204068549;880.2429910277157;887.1660638999384;892.9196372326522;10057.195424366033;10098.848517272247;10147.086762191364;10194.23543234253;10207.18342532603;3991.820368083443;4118.979405103015;4204.621584057389;4252.085801552681;4264.211120942636;8419;8486.915130848613;8491.830163396697;8509.404341696145;8509.957450212709;4528.88677783058;4547.590716835501;4548.840790572314;4549.727016379028;4552.453705555355;4027.5368332641533;4131.97934010334;4140;4141.668666506672;4144.44050053245;3501.7898926064518;3549.591796943333;3563.3051554946537;3606.8196590170387;3614.1145419372424;1038.1072277841051;1169.9356535390466;1198.5864876617552;1206.4329765010432;1206.7888119579038;623.8783437229787;770.6763159472923;844.9197326253995;861.3152543727751;873.5413907698509;4992.875178120504;5143.12566863634;5202.817901373433;5232.136697444879;5274.918641678447;823.9382046346548;844.8310337932315;859.4787226608992;861.5562985062697;885.880406145175;3594.2452085061905;3632.4551317302617;3647.507586475845;3650.142216579102;3694.833732482045;8817.867731984026;9247.72256832296;9321;9321;9346.345755797029;9218.769530761785;9224.123708247706;9225.53872306382;9237.630494780267;9252.352335336596;5913.556483263773;6144;7071.045408869737;7075.681594328267;7234.710611575583;5101.6735648730855;5218.321618189611;5268.2624432578705;5347.652402593974;5374.946250537445;8599.484030958163;8672.609732562176;8675.089115643019;8685.174908383693;8690.34822388336;8108.635111419882;8441.746747597583;8454.746357609281;8671.869921951049;8738.169873862227;6329.936700632935;6439.484841212598;6454.386833250834;6459.321771213955;6471.255805582418;7126.679299431435;7192.136943566806;7194.352508274281;7197.964010180125;7199.208087110518;6607.636579987954;6743.494237932273;6759.121314229119;6883.070785443901;6910.861782764216;6513.609183449008;6531.281559028408;6735.764248251287;6788.321167883172;6795.150606174228;6173.536984726074;6199.969000154971;6248.094026366242;6257.1552840367785;6260.561760676709;4482.215612267775;4524.683272170916;4606.355110284496;4636.6058884995155;4658.394408726979;4449;4483;4493.236149854467;4591.311303304397;4616.953830461653 17:17:42 INFO - PROCESS | 3409 | |4;prototype.html;291.73452158535724;298.11757198691873;303.3493157177854;305.7538681361506;307.7215120316115;4788.760561971901;4838.951610483894;4842.636802239828;4844.152273352162;4846.660733748639;4517.41273634427;4603.240465323226;4634.652401069917;4635.374224479694;4808.471068182497;3687.3362794696945;3691.7600355976774;3709.6846768024616;3777.508923839897;3795.563510196321;3762.454444105603;3800.600936901627;3800.6579407853287;3812.504374431334;3813.0657988792786;3646.6353364663455;3780;3793.696504279651;3804.1250512382167;3804.8287827047848;3758.8308526116116;3776.754510956779;3783.2244389900006;3805.162864169878;3806.143617686026;3339.098443420263;3348.7655864089525;3349.380364632551;3369.107186595554;3381.898543043713;4692.530746925314;4718.197906355927;4720.811167553294;4727.409073865767;4730.503297153784;4144.937825932613;4286.614204721559;4308.535098066673;4317.69776115672;4342.348647702838;4960.528749768766;4965.329680493123;4967.50324967504;4975.402951645826;4984.925226121611;3650.361186792301;3653.1780349421433;3670.137517683342;3672.4491326301;3684.5762737285286;5001.374828146481;5230.686158830445;5234.057869583511;5244.973775131138;5270.736463176864;3570.125319296789;3582.549067627615;3590.281943611288;3591.3356029134693;3592.7245827731304;3623.166671665532;3641.927161456756;3643.7813731176216;3651.8904432867057;3653.209927135684;4215.283401821697;4221.662267018631;4223.965128543527;4230.344296634026;4235.174141042467;4791.448983366888;5004.599632029429;5009.499050094962;5026.843825920059;5050.72221027847;1225.4179264849126;1254.786686263319;1267.7211013576998;1271.4659842865833;1278.2011242973142;822.3174764945081;831.9292860106838;833.3541505333416;835.1731785532279;862.857628491292;4454.821807127679;4471.128130014616;4476.619487343547;4476.955230447654;4482.148391805546;5087.211482220262;5100.923486147711;5123.641345105882;5137.743112844343;5142.688614403303;4331.956680433218;4516.683832131719;4521.344405061248;4574.6569007323915;4632.837850675211;2758.1863350311705;2759.84820834856;2771.057840334296;2772;2788.6235358226786;4965.82619608312;4994.225894986283;4998.875028124326;5008.824691135793;5041.59667226621;5050.696958182521;5260.815871444481;5286.784039670897;5291.708956007379;5300.932636271857;4900.607951363882;4939.75301234944;4945.381827271591;4952.2819191217795;4979.45226025137;5160.174372100446;5177.844664660066;5180.248863914787;5190.870228244324;5198.506141916512;4902.779374928208;5013.39839219296;5037.244413338029;5054.941760235152;5065;4939.382577177853;4944.071811993397;4957.380327459067;4957.7273249971595;4968;3609.729270304685;3610.079429745398;3624.5106910566737;3632.3643362412;3647.1793846385413;4977.427595826382;5143.351174145243;5163.948360516347;5197.168453047494;5245.632805703564;4970.9254361183885;4983.3621456337805;5008.949910500848;5011.123053465702;5052.444231134498;4984;4995.550400463976;5012.122878496321;5019.472955339636;5026.4973502649445;4678.8596342109795;4772.546608072227;4779.378680771617;4887.560119589254;4896.192128298933;5011.348524691913;5032.823851165192;5033.245013248042;5035.420926593342;5054.342935418372;4942.258661200849;4961.387549046646;4966;4970.155073637418;4976.129177394014 17:17:42 INFO - PROCESS | 3409 | |5;yui.html;611.8164550634809;667.4626925325115;678.4504551313437;679.5039621076611;679.5752654590879;11385.544578216872;12123.636290911276;12152.635420937386;12158.392080395977;12175.086868484856;12374.443150058247;12521;12527;12531.310777907234;12549.937250313758;622.9190205273308;760.5854809129011;763.1529002806866;786.9763907082797;791.1732239809413;780.59019015017;783.4163548156631;785.2657764989724;785.45018487059;788.2511613966726;829.0300348592132;830.1615368477851;830.3606223208126;830.7258604660477;831.3930830493744;635.0854769132435;646.4666650013758;650.8926027205505;651.7588492257895;826.3182874128838;583.1573376471001;601.8044135655929;602.0337358539568;603.5111559636708;606.3209205689656;12143.271403715806;12177.51289948401;12181.817272740827;12276.570320038756;12733.55432559856;12560;12867.742645147138;13017.28404937728;13103.803442948269;13106.737865242738;11444.94277528607;11633.767324653545;11820.822687659693;11928.522859085626;12337.814932776015;4073.0835561998315;4075.4498142750645;4137.54487006429;4259;4264.25375559279;62692.37307626956;62991.37008629947;63522.7295454093;63654;63704;10389.636362727268;10449.738756530995;10450;10547.208959328082;10563.207759418074;18280.360187393377;18281.542961426072;18289.542761431072;18293.54266143357;18319.633607328044;6843.692033858489;6921.238663746984;6999.09011828459;7079.716811327489;7170.569765814068;3519.0674471265133;3577.266660334625;3581.5702115746276;3687.2809802088873;3748.7188460865;2689.9193024209303;2806.4527417153868;2811.1144989328295;2813.85930703464;2815.5213613685723;491.3587767962843;507.6649411388466;511.9334486516729;516.5093161496593;516.8526969813585;514.4109994056784;570.6661602962314;588.9806180831891;621.5214285000525;646.6766616691655;8452.366072544584;8925.553722313858;9699.806003879883;9884.703458896245;9918.752031199278;491.3195224613864;569.8432930943941;573.4466240078344;588.5262363797184;636.6243916089529;3868.845246190177;4300.634446072119;4332.566743325642;4333.609975102256;4388.51726310112;91839.54080229557;93162.53418732862;94657.526712366;96063.51968240253;97393;83079;84583;85493.57253213819;85572;85639.57180214184;44611.77694111509;49776.75111624419;73024.63487682528;73803;74794.25205747981;8747.781305467413;9368.156865882103;9423.481708506099;9495.050494950727;9504.19214366759;39589.40615890821;44514.3322850151;46096.539034609224;46372.30441543312;47405.76297118492;57043;64361;64994.675026624565;65714;65714.34285657082;11559.768804623693;11667.708307292385;11793.174477786473;11889;11926.940365298118;12278.508859645513;12377.62867113988;12412.62762117138;12952.093353465167;13087.934560327138;12156.574519891761;12332.691682708004;12364.381780911099;12436.626901192978;12526.686832829253;12093.818592721293;12324.445399956845;12443.564475243324;12510.499580017062;12981.415836287579;12073.335966521574;12420.441080151235;12514.43685034194;12592;12675.93662031684;10286.331388459726;10347.63783267582;10468.528916198942;10540.10409115203;10897.073748731129;10687.412192329497;10790.329477986746;10844.349339039683;10896.346219226873;10896.509657065293 17:17:42 INFO - PROCESS | 3409 | __end_tp_report 17:17:42 INFO - PROCESS | 3409 | __start_cc_report 17:17:42 INFO - PROCESS | 3409 | _x_x_mozilla_cycle_collect,1061 17:17:42 INFO - PROCESS | 3409 | __end_cc_report 17:17:42 INFO - PROCESS | 3409 | __startTimestamp1468369062347__endTimestamp 17:17:42 INFO - PROCESS | 3409 | 17:17:42 INFO - PROCESS | 3409 | ------- Summary: start ------- 17:17:42 INFO - PROCESS | 3409 | Number of tests: 6 17:17:42 INFO - PROCESS | 3409 | 17:17:42 INFO - PROCESS | 3409 | [#0] dojo.html Cycles:165 Average:4573.18 Median:4709.95 stddev:482.40 (10.2%) stddev-sans-first:457.44 17:17:42 INFO - PROCESS | 3409 | Values: 2564.9 2583.2 2603.2 2610.5 2611.2 4470.1 4540.7 4559.5 4575.2 4588.2 4592.7 4611.5 4625.5 4659.8 4662.0 4018.5 4156.6 4260.9 4285.4 4359.2 4267.2 4337.4 4340.0 4346.2 4369.3 4144.6 4181.6 4204.1 4209.7 4224.2 4181.9 4189.0 4189.9 4264.0 4296.4 4284.5 4295.8 4312.4 4339.7 4350.8 4484.8 4563.5 4598.1 4686.7 4710.0 4936.6 4936.7 4960.2 4968.7 4973.0 4988.8 5006.2 5018.7 5021.1 5021.4 4500.1 4615.3 4669.2 4680.8 4698.4 5140.6 5152.7 5158.5 5161.7 5166.8 4902.1 4939.6 4955.9 4957.7 4960.0 4813.7 4900.9 4940.5 4967.2 5014.4 4893.9 4899.8 4908.1 4909.4 4942.3 4884.2 4886.1 4886.8 4924.5 4939.8 4060.6 4089.9 4109.4 4149.1 4178.1 3626.2 3646.2 3669.3 3673.5 3707.0 4298.1 4301.8 4307.3 4307.5 4351.9 4765.5 4834.4 4860.4 4870.2 4956.2 4256.1 4279.9 4280.5 4284.9 4318.2 4381.8 4405.5 4408.6 4432.3 4436.0 4612.4 4646.5 4722.1 4727.4 4760.4 4953.7 4954.9 4956.1 4970.5 4988.4 4733.1 4733.3 4733.5 4744.3 4795.4 4668.1 4803.3 4834.2 4854.0 4881.7 4907.5 4929.4 4935.6 4942.2 4980.4 4673.0 4797.1 4802.4 4815.7 4859.4 4802.9 4845.1 4851.0 4863.3 4882.4 4773.2 4805.4 4821.4 4854.8 4862.1 4703.6 4730.4 4912.6 4915.1 4948.7 4675.2 4687.1 4690.2 4715.2 4760.2 17:17:42 INFO - PROCESS | 3409 | 17:17:42 INFO - PROCESS | 3409 | [#1] ext.html Cycles:180 Average:48511.72 Median:344226.00 stddev:87955.64 (25.6%) stddev-sans-first:88128.73 17:17:42 INFO - PROCESS | 3409 | Values: 572.5 573.1 581.8 586.0 587.1 27424.9 29850.0 29965.4 40341.4 41673.0 42473.4 42958.6 42976.4 43034.4 43051.4 7847.6 7950.7 7957.3 7964.3 7995.3 7514.1 7862.3 10074.7 10349.8 10355.3 10349.7 10400.5 10419.0 10423.7 10433.0 7672.3 10296.1 10341.3 10360.8 10369.2 9907.1 10310.5 10323.2 10646.1 10661.1 39446.0 39594.2 39756.8 39761.8 39779.0 3073.9 3081.5 3361.3 3588.4 3747.5 29846.4 29979.3 30437.5 30462.5 31413.4 3514.1 3518.6 3530.6 3537.9 3618.7 267190.0 267294.0 267412.0 267491.0 267857.0 54575.0 55051.7 55098.2 55143.7 55196.2 33392.0 34302.3 34441.0 36398.1 36420.5 15997.3 16099.3 16145.2 16164.8 16201.7 10991.9 11762.2 12040.3 12106.3 12121.7 18141.7 18851.2 18877.5 18920.3 18943.7 6763.6 6865.8 6873.2 6942.0 6974.2 801.4 884.1 987.1 1017.5 1025.5 27880.7 28705.3 28707.0 28859.0 29218.0 975.3 975.4 984.4 994.4 1053.6 15226.5 15236.0 15425.0 15571.3 15721.7 379259.0 382231.0 382352.0 385023.8 385400.0 49587.0 50155.0 50160.2 50321.0 50355.0 1068.4 1123.1 1127.8 1164.2 1205.7 19421.9 29312.0 29517.9 31243.4 31454.5 46915.3 47515.5 47525.0 47547.0 47652.3 337462.0 344017.0 344132.0 344320.0 345734.0 22419.6 22929.2 24843.0 25514.4 25571.7 42432.0 42498.4 42591.8 42643.1 43248.8 36373.8 36696.1 36779.8 37157.0 37251.4 36972.6 37502.8 37541.0 37695.8 37951.8 34344.5 34627.3 35205.0 35229.8 35375.3 31627.4 32688.1 32942.7 33335.7 33583.5 24952.9 24955.5 25273.0 25480.9 25790.5 17:17:42 INFO - PROCESS | 3409 | 17:17:42 INFO - PROCESS | 3409 | [#2] jquery.html Cycles:180 Average:22628.12 Median:28896.40 stddev:55334.68 (191.5%) stddev-sans-first:55464.64 17:17:42 INFO - PROCESS | 3409 | Values: 356.5 358.9 371.9 372.4 393.1 17342.7 17362.8 18326.5 18333.2 18350.4 15855.3 16243.2 16288.2 16502.2 16541.0 5102.8 5274.2 5308.8 5319.1 5319.8 3863.2 4053.7 5239.6 6055.4 6367.9 6375.8 6408.6 6408.8 6437.8 6445.0 5370.7 5655.6 5663.1 5741.6 5753.3 3383.0 5038.0 5333.6 5350.2 5564.0 12306.9 12483.8 12501.7 14469.3 20803.9 1900.2 1945.9 2102.9 2139.5 2401.4 8912.9 9335.8 9859.8 10417.6 13967.5 1537.0 1750.4 1760.6 1787.3 1849.8 69260.7 71087.3 72051.0 72119.0 72591.6 10162.9 10238.3 10323.1 10654.8 10895.7 13912.7 14026.1 14029.6 14029.6 14031.4 7250.4 7260.7 7277.7 7324.8 7481.1 6819.0 6929.2 7011.1 7013.3 7016.7 4427.0 4462.5 4509.4 4511.0 4562.2 1627.6 1718.2 1727.7 1736.3 1796.2 714.6 853.2 862.4 870.2 899.6 17150.0 17286.7 17699.6 17782.7 18100.3 874.4 877.3 893.8 909.5 925.0 9603.2 9673.8 9973.5 10207.2 10461.1 276315.0 281041.0 283108.0 387603.0 399704.0 77504.0 81528.0 81608.6 84493.6 85816.0 926.7 952.1 974.8 979.4 980.0 16172.0 16432.3 16436.0 16565.9 17010.9 39069.0 39073.4 39084.4 39844.4 39961.6 48452.3 52553.2 54015.0 54287.7 54642.0 7062.8 7100.6 7370.6 7414.0 7437.4 9839.9 10067.8 10342.6 10713.4 11115.2 4616.0 4738.8 6380.7 9338.8 9443.9 9021.7 9268.8 9319.5 9356.1 9769.0 9702.3 9784.4 10019.8 10033.6 10170.1 7288.4 7318.6 7402.7 7419.4 7423.8 7831.6 9568.9 9759.7 9889.6 10037.2 17:17:42 INFO - PROCESS | 3409 | 17:17:42 INFO - PROCESS | 3409 | [#3] mootools.html Cycles:180 Average:4970.82 Median:5250.20 stddev:2712.98 (51.7%) stddev-sans-first:2705.81 17:17:42 INFO - PROCESS | 3409 | Values: 1202.8 1249.7 1323.0 1675.3 1689.0 7034.8 7380.1 7458.4 7472.3 7485.9 6408.5 7016.4 7163.7 7220.4 7487.4 2168.2 2193.5 2197.4 2199.4 2200.8 2091.3 2128.6 2188.2 2189.4 2190.7 1843.1 2124.5 2192.3 2196.3 2221.2 2172.2 2178.9 2196.4 2200.7 2205.0 2133.9 2143.0 2144.8 2145.8 2146.7 7323.3 7395.1 7418.7 7431.6 7435.3 4403.5 4541.6 4544.5 4548.7 4548.8 2798.5 2854.9 2953.4 2960.1 2961.2 877.3 879.3 880.2 887.2 892.9 10057.2 10098.8 10147.1 10194.2 10207.2 3991.8 4119.0 4204.6 4252.1 4264.2 8419.0 8486.9 8491.8 8509.4 8510.0 4528.9 4547.6 4548.8 4549.7 4552.5 4027.5 4132.0 4140.0 4141.7 4144.4 3501.8 3549.6 3563.3 3606.8 3614.1 1038.1 1169.9 1198.6 1206.4 1206.8 623.9 770.7 844.9 861.3 873.5 4992.9 5143.1 5202.8 5232.1 5274.9 823.9 844.8 859.5 861.6 885.9 3594.2 3632.5 3647.5 3650.1 3694.8 8817.9 9247.7 9321.0 9321.0 9346.3 9218.8 9224.1 9225.5 9237.6 9252.4 5913.6 6144.0 7071.0 7075.7 7234.7 5101.7 5218.3 5268.3 5347.7 5374.9 8599.5 8672.6 8675.1 8685.2 8690.3 8108.6 8441.7 8454.7 8671.9 8738.2 6329.9 6439.5 6454.4 6459.3 6471.3 7126.7 7192.1 7194.4 7198.0 7199.2 6607.6 6743.5 6759.1 6883.1 6910.9 6513.6 6531.3 6735.8 6788.3 6795.2 6173.5 6200.0 6248.1 6257.2 6260.6 4482.2 4524.7 4606.4 4636.6 4658.4 4449.0 4483.0 4493.2 4591.3 4617.0 17:17:42 INFO - PROCESS | 3409 | 17:17:42 INFO - PROCESS | 3409 | [#4] prototype.html Cycles:180 Average:4176.75 Median:4775.96 stddev:1209.77 (25.3%) stddev-sans-first:1177.50 17:17:42 INFO - PROCESS | 3409 | Values: 291.7 298.1 303.3 305.8 307.7 4788.8 4839.0 4842.6 4844.2 4846.7 4517.4 4603.2 4634.7 4635.4 4808.5 3687.3 3691.8 3709.7 3777.5 3795.6 3762.5 3800.6 3800.7 3812.5 3813.1 3646.6 3780.0 3793.7 3804.1 3804.8 3758.8 3776.8 3783.2 3805.2 3806.1 3339.1 3348.8 3349.4 3369.1 3381.9 4692.5 4718.2 4720.8 4727.4 4730.5 4144.9 4286.6 4308.5 4317.7 4342.3 4960.5 4965.3 4967.5 4975.4 4984.9 3650.4 3653.2 3670.1 3672.4 3684.6 5001.4 5230.7 5234.1 5245.0 5270.7 3570.1 3582.5 3590.3 3591.3 3592.7 3623.2 3641.9 3643.8 3651.9 3653.2 4215.3 4221.7 4224.0 4230.3 4235.2 4791.4 5004.6 5009.5 5026.8 5050.7 1225.4 1254.8 1267.7 1271.5 1278.2 822.3 831.9 833.4 835.2 862.9 4454.8 4471.1 4476.6 4477.0 4482.1 5087.2 5100.9 5123.6 5137.7 5142.7 4332.0 4516.7 4521.3 4574.7 4632.8 2758.2 2759.8 2771.1 2772.0 2788.6 4965.8 4994.2 4998.9 5008.8 5041.6 5050.7 5260.8 5286.8 5291.7 5300.9 4900.6 4939.8 4945.4 4952.3 4979.5 5160.2 5177.8 5180.2 5190.9 5198.5 4902.8 5013.4 5037.2 5054.9 5065.0 4939.4 4944.1 4957.4 4957.7 4968.0 3609.7 3610.1 3624.5 3632.4 3647.2 4977.4 5143.4 5163.9 5197.2 5245.6 4970.9 4983.4 5008.9 5011.1 5052.4 4984.0 4995.6 5012.1 5019.5 5026.5 4678.9 4772.5 4779.4 4887.6 4896.2 5011.3 5032.8 5033.2 5035.4 5054.3 4942.3 4961.4 4966.0 4970.2 4976.1 17:17:42 INFO - PROCESS | 3409 | 17:17:42 INFO - PROCESS | 3409 | [#5] yui.html Cycles:180 Average:17616.65 Median:24451.42 stddev:24625.31 (100.7%) stddev-sans-first:24661.29 17:17:42 INFO - PROCESS | 3409 | Values: 611.8 667.5 678.5 679.5 679.6 11385.5 12123.6 12152.6 12158.4 12175.1 12374.4 12521.0 12527.0 12531.3 12549.9 622.9 760.6 763.2 787.0 791.2 780.6 783.4 785.3 785.5 788.3 829.0 830.2 830.4 830.7 831.4 635.1 646.5 650.9 651.8 826.3 583.2 601.8 602.0 603.5 606.3 12143.3 12177.5 12181.8 12276.6 12733.6 12560.0 12867.7 13017.3 13103.8 13106.7 11444.9 11633.8 11820.8 11928.5 12337.8 4073.1 4075.4 4137.5 4259.0 4264.3 62692.4 62991.4 63522.7 63654.0 63704.0 10389.6 10449.7 10450.0 10547.2 10563.2 18280.4 18281.5 18289.5 18293.5 18319.6 6843.7 6921.2 6999.1 7079.7 7170.6 3519.1 3577.3 3581.6 3687.3 3748.7 2689.9 2806.5 2811.1 2813.9 2815.5 491.4 507.7 511.9 516.5 516.9 514.4 570.7 589.0 621.5 646.7 8452.4 8925.6 9699.8 9884.7 9918.8 491.3 569.8 573.4 588.5 636.6 3868.8 4300.6 4332.6 4333.6 4388.5 91839.5 93162.5 94657.5 96063.5 97393.0 83079.0 84583.0 85493.6 85572.0 85639.6 44611.8 49776.8 73024.6 73803.0 74794.3 8747.8 9368.2 9423.5 9495.1 9504.2 39589.4 44514.3 46096.5 46372.3 47405.8 57043.0 64361.0 64994.7 65714.0 65714.3 11559.8 11667.7 11793.2 11889.0 11926.9 12278.5 12377.6 12412.6 12952.1 13087.9 12156.6 12332.7 12364.4 12436.6 12526.7 12093.8 12324.4 12443.6 12510.5 12981.4 12073.3 12420.4 12514.4 12592.0 12675.9 10286.3 10347.6 10468.5 10540.1 10897.1 10687.4 10790.3 10844.3 10896.3 10896.5 17:17:42 INFO - PROCESS | 3409 | -------- Summary: end -------- 17:17:42 INFO - PROCESS | 3409 | 17:17:43 INFO - TEST-INFO | 3409: exit 0 17:17:43 INFO - TEST-OK | dromaeo_css | took 1121173ms 17:17:43 INFO - TEST-START | kraken 17:17:43 INFO - operating with platform_type : linux_ 17:17:43 INFO - Initialising browser for kraken test... 17:17:43 INFO - TEST-INFO | started process 3601 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt74htW/profile http://localhost:39004/getInfo.html) 17:17:47 INFO - PROCESS | 3601 | __metrics Screen width/height:1600/1200 17:17:47 INFO - PROCESS | 3601 | colorDepth:24 17:17:47 INFO - PROCESS | 3601 | Browser inner width/height: 1024/697 17:17:47 INFO - PROCESS | 3601 | __metrics 17:17:48 INFO - PROCESS | 3601 | 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" 17:17:48 INFO - PROCESS | 3601 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:17:49 INFO - TEST-INFO | 3601: exit 0 17:17:49 INFO - Browser initialized. 17:17:49 INFO - Running cycle 1/1 for kraken test... 17:17:49 INFO - TEST-INFO | started process 3682 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt74htW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:18:01 INFO - PROCESS | 3682 | RSS: Main: 159137792 17:18:01 INFO - PROCESS | 3682 | 17:18:04 INFO - PROCESS | 3682 | Cycle 1(1): loaded http://localhost:39004/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39004/tests/kraken/driver.html?testName=audio-beat-detection) 17:18:05 INFO - PROCESS | 3682 | RSS: Main: 216858624 17:18:05 INFO - PROCESS | 3682 | 17:18:08 INFO - PROCESS | 3682 | Cycle 1(1): loaded http://localhost:39004/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39004/tests/kraken/driver.html?testName=audio-dft) 17:18:08 INFO - PROCESS | 3682 | RSS: Main: 204537856 17:18:08 INFO - PROCESS | 3682 | 17:18:12 INFO - PROCESS | 3682 | Cycle 1(1): loaded http://localhost:39004/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39004/tests/kraken/driver.html?testName=audio-fft) 17:18:12 INFO - PROCESS | 3682 | RSS: Main: 270966784 17:18:12 INFO - PROCESS | 3682 | 17:18:14 INFO - PROCESS | 3682 | Cycle 1(1): loaded http://localhost:39004/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39004/tests/kraken/driver.html?testName=audio-oscillator) 17:18:15 INFO - PROCESS | 3682 | RSS: Main: 181305344 17:18:15 INFO - PROCESS | 3682 | 17:18:17 INFO - PROCESS | 3682 | Cycle 1(1): loaded http://localhost:39004/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39004/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:18:18 INFO - PROCESS | 3682 | RSS: Main: 185069568 17:18:18 INFO - PROCESS | 3682 | 17:18:21 INFO - PROCESS | 3682 | Cycle 1(1): loaded http://localhost:39004/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39004/tests/kraken/driver.html?testName=imaging-darkroom) 17:18:22 INFO - PROCESS | 3682 | RSS: Main: 221528064 17:18:22 INFO - PROCESS | 3682 | 17:18:25 INFO - PROCESS | 3682 | Cycle 1(1): loaded http://localhost:39004/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39004/tests/kraken/driver.html?testName=imaging-desaturate) 17:18:26 INFO - PROCESS | 3682 | RSS: Main: 222568448 17:18:26 INFO - PROCESS | 3682 | 17:18:29 INFO - PROCESS | 3682 | Cycle 1(1): loaded http://localhost:39004/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39004/tests/kraken/driver.html?testName=json-parse-financial) 17:18:29 INFO - PROCESS | 3682 | RSS: Main: 222261248 17:18:29 INFO - PROCESS | 3682 | 17:18:31 INFO - PROCESS | 3682 | Cycle 1(1): loaded http://localhost:39004/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39004/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:18:31 INFO - PROCESS | 3682 | RSS: Main: 208769024 17:18:31 INFO - PROCESS | 3682 | 17:18:33 INFO - PROCESS | 3682 | Cycle 1(1): loaded http://localhost:39004/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39004/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:18:34 INFO - PROCESS | 3682 | RSS: Main: 211509248 17:18:34 INFO - PROCESS | 3682 | 17:18:36 INFO - PROCESS | 3682 | Cycle 1(1): loaded http://localhost:39004/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39004/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:18:37 INFO - PROCESS | 3682 | RSS: Main: 211095552 17:18:37 INFO - PROCESS | 3682 | 17:18:40 INFO - PROCESS | 3682 | Cycle 1(1): loaded http://localhost:39004/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39004/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:18:41 INFO - PROCESS | 3682 | RSS: Main: 224616448 17:18:41 INFO - PROCESS | 3682 | 17:18:44 INFO - PROCESS | 3682 | Cycle 1(1): loaded http://localhost:39004/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39004/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:18:44 INFO - PROCESS | 3682 | RSS: Main: 225665024 17:18:44 INFO - PROCESS | 3682 | 17:18:46 INFO - PROCESS | 3682 | Cycle 1(1): loaded http://localhost:39004/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39004/tests/kraken/driver.html?testName=ai-astar) 17:18:46 INFO - PROCESS | 3682 | RSS: Main: 268173312 17:18:46 INFO - PROCESS | 3682 | 17:18:46 INFO - PROCESS | 3682 | __start_tp_report 17:18:46 INFO - PROCESS | 3682 | _x_x_mozilla_page_load 17:18:46 INFO - PROCESS | 3682 | _x_x_mozilla_page_load_details 17:18:46 INFO - PROCESS | 3682 | |i|pagename|runs| 17:18:46 INFO - PROCESS | 3682 | |0;ai-astar;106;116;114;116;115;115;114;114;114;114 17:18:46 INFO - PROCESS | 3682 | |1;audio-beat-detection;155;124;124;181;125;125;150;121;174;127 17:18:46 INFO - PROCESS | 3682 | |2;audio-dft;161;161;161;163;163;162;160;161;161;161 17:18:46 INFO - PROCESS | 3682 | |3;audio-fft;76;77;75;112;76;76;75;74;98;74 17:18:46 INFO - PROCESS | 3682 | |4;audio-oscillator;86;84;117;84;85;84;119;88;86;122 17:18:46 INFO - PROCESS | 3682 | |5;imaging-gaussian-blur;117;116;117;117;117;116;116;117;117;116 17:18:46 INFO - PROCESS | 3682 | |6;imaging-darkroom;147;147;146;147;147;146;146;147;147;146 17:18:46 INFO - PROCESS | 3682 | |7;imaging-desaturate;95;95;95;94;95;94;95;95;95;95 17:18:46 INFO - PROCESS | 3682 | |8;json-parse-financial;62;62;72;62;62;62;63;61;62;61 17:18:46 INFO - PROCESS | 3682 | |9;json-stringify-tinderbox;65;64;65;65;65;65;65;65;65;64 17:18:46 INFO - PROCESS | 3682 | |10;stanford-crypto-aes;81;84;78;78;88;78;78;81;77;83 17:18:46 INFO - PROCESS | 3682 | |11;stanford-crypto-ccm;134;135;134;136;124;129;129;128;167;138 17:18:46 INFO - PROCESS | 3682 | |12;stanford-crypto-pbkdf2;164;171;163;164;167;169;168;163;163;164 17:18:46 INFO - PROCESS | 3682 | |13;stanford-crypto-sha256-iterative;68;67;67;66;67;66;65;66;64;64 17:18:46 INFO - PROCESS | 3682 | __end_tp_report 17:18:46 INFO - PROCESS | 3682 | __start_cc_report 17:18:46 INFO - PROCESS | 3682 | _x_x_mozilla_cycle_collect,1934 17:18:46 INFO - PROCESS | 3682 | __end_cc_report 17:18:46 INFO - PROCESS | 3682 | __startTimestamp1468369126684__endTimestamp 17:18:46 INFO - PROCESS | 3682 | 17:18:46 INFO - PROCESS | 3682 | ------- Summary: start ------- 17:18:46 INFO - PROCESS | 3682 | Number of tests: 14 17:18:46 INFO - PROCESS | 3682 | 17:18:46 INFO - PROCESS | 3682 | [#0] ai-astar Cycles:10 Average:113.80 Median:114.50 stddev:2.86 (2.5%) stddev-sans-first:0.87 17:18:46 INFO - PROCESS | 3682 | Values: 106.0 116.0 114.0 116.0 115.0 115.0 114.0 114.0 114.0 114.0 17:18:46 INFO - PROCESS | 3682 | 17:18:46 INFO - PROCESS | 3682 | [#1] audio-beat-detection Cycles:10 Average:140.60 Median:138.50 stddev:22.73 (16.4%) stddev-sans-first:23.51 17:18:46 INFO - PROCESS | 3682 | Values: 155.0 124.0 124.0 181.0 125.0 125.0 150.0 121.0 174.0 127.0 17:18:46 INFO - PROCESS | 3682 | 17:18:46 INFO - PROCESS | 3682 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.00 stddev:0.97 (0.6%) stddev-sans-first:1.01 17:18:46 INFO - PROCESS | 3682 | Values: 161.0 161.0 161.0 163.0 163.0 162.0 160.0 161.0 161.0 161.0 17:18:46 INFO - PROCESS | 3682 | 17:18:46 INFO - PROCESS | 3682 | [#3] audio-fft Cycles:10 Average:81.30 Median:76.00 stddev:12.95 (17.0%) stddev-sans-first:13.60 17:18:46 INFO - PROCESS | 3682 | Values: 76.0 77.0 75.0 112.0 76.0 76.0 75.0 74.0 98.0 74.0 17:18:46 INFO - PROCESS | 3682 | 17:18:46 INFO - PROCESS | 3682 | [#4] audio-oscillator Cycles:10 Average:95.50 Median:84.50 stddev:16.53 (19.6%) stddev-sans-first:17.18 17:18:46 INFO - PROCESS | 3682 | Values: 86.0 84.0 117.0 84.0 85.0 84.0 119.0 88.0 86.0 122.0 17:18:46 INFO - PROCESS | 3682 | 17:18:46 INFO - PROCESS | 3682 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 17:18:46 INFO - PROCESS | 3682 | Values: 117.0 116.0 117.0 117.0 117.0 116.0 116.0 117.0 117.0 116.0 17:18:46 INFO - PROCESS | 3682 | 17:18:46 INFO - PROCESS | 3682 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 17:18:46 INFO - PROCESS | 3682 | Values: 147.0 147.0 146.0 147.0 147.0 146.0 146.0 147.0 147.0 146.0 17:18:46 INFO - PROCESS | 3682 | 17:18:46 INFO - PROCESS | 3682 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 17:18:46 INFO - PROCESS | 3682 | Values: 95.0 95.0 95.0 94.0 95.0 94.0 95.0 95.0 95.0 95.0 17:18:46 INFO - PROCESS | 3682 | 17:18:46 INFO - PROCESS | 3682 | [#8] json-parse-financial Cycles:10 Average:62.90 Median:62.00 stddev:3.25 (5.2%) stddev-sans-first:3.43 17:18:46 INFO - PROCESS | 3682 | Values: 62.0 62.0 72.0 62.0 62.0 62.0 63.0 61.0 62.0 61.0 17:18:46 INFO - PROCESS | 3682 | 17:18:46 INFO - PROCESS | 3682 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:65.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 17:18:46 INFO - PROCESS | 3682 | Values: 65.0 64.0 65.0 65.0 65.0 65.0 65.0 65.0 65.0 64.0 17:18:46 INFO - PROCESS | 3682 | 17:18:46 INFO - PROCESS | 3682 | [#10] stanford-crypto-aes Cycles:10 Average:80.60 Median:81.00 stddev:3.53 (4.4%) stddev-sans-first:3.75 17:18:46 INFO - PROCESS | 3682 | Values: 81.0 84.0 78.0 78.0 88.0 78.0 78.0 81.0 77.0 83.0 17:18:46 INFO - PROCESS | 3682 | 17:18:46 INFO - PROCESS | 3682 | [#11] stanford-crypto-ccm Cycles:10 Average:135.40 Median:134.50 stddev:11.91 (8.9%) stddev-sans-first:12.62 17:18:46 INFO - PROCESS | 3682 | Values: 134.0 135.0 134.0 136.0 124.0 129.0 129.0 128.0 167.0 138.0 17:18:46 INFO - PROCESS | 3682 | 17:18:46 INFO - PROCESS | 3682 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.60 Median:165.50 stddev:2.91 (1.8%) stddev-sans-first:3.03 17:18:46 INFO - PROCESS | 3682 | Values: 164.0 171.0 163.0 164.0 167.0 169.0 168.0 163.0 163.0 164.0 17:18:46 INFO - PROCESS | 3682 | 17:18:46 INFO - PROCESS | 3682 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.50 stddev:1.33 (2.0%) stddev-sans-first:1.20 17:18:46 INFO - PROCESS | 3682 | Values: 68.0 67.0 67.0 66.0 67.0 66.0 65.0 66.0 64.0 64.0 17:18:46 INFO - PROCESS | 3682 | -------- Summary: end -------- 17:18:46 INFO - PROCESS | 3682 | 17:18:47 INFO - TEST-INFO | 3682: exit 0 17:18:47 INFO - TEST-OK | kraken | took 64597ms 17:18:47 INFO - SUITE-END | took 1185s 17:18:47 INFO - Completed test suite (00:19:45) 17:18:47 INFO - javascript benchmark 17:18:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2564.8717564121794, 2583.237944806282, 2603.1799983005353, 2610.5301045811757, 2611.1774790940854, 4470.128324976631, 4540.70485418448, 4559.452865656126, 4575.1764682357125, 4588.151192029472, 4592.72443653381, 4611.469680986687, 4625.468071171807, 4659.767011649413, 4661.953380466202, 4018.5177778666603, 4156.5635608261155, 4260.850870219543, 4285.378620100084, 4359.171757366106, 4267.1892340455215, 4337.371081193225, 4340.02349471368, 4346.195953748566, 4369.3227549729845, 4144.606262405082, 4181.60274773896, 4204.138151678929, 4209.7474151551005, 4224.176285624305, 4181.895452613679, 4189.036521600018, 4189.853355132555, 4264.04059086703, 4296.441462609872, 4284.528701842794, 4295.8281668733525, 4312.439382880237, 4339.6528277738025, 4350.782460876975, 4484.8206071757095, 4563.452385713703, 4598.103369842882, 4686.718796872198, 4709.95290047102, 4936.6050715943, 4936.679115857458, 4960.23116416956, 4968.701877887338, 4973.030259099477, 4988.82539111133, 5006.249062640633, 5018.698878067327, 5021.096202683516, 5021.44764075955, 4500.122476117126, 4615.26155815068, 4669.2062349400685, 4680.765961701902, 4698.4361876574685, 5140.563052140536, 5152.6650767699975, 5158.484151584887, 5161.716105614152, 5166.844994650167, 4902.117618828645, 4939.629527785431, 4955.8513244602, 4957.7273249971595, 4959.975200124049, 4813.7352445615825, 4900.877478063006, 4940.456549779521, 4967.155583550805, 5014.373203349582, 4893.884632784675, 4899.755012249373, 4908.067467181224, 4909.361782968192, 4942.308076869242, 4884.169691152512, 4886.144924638245, 4886.828960986349, 4924.482929292444, 4939.827106051271, 4060.614241647039, 4089.89775255621, 4109.4246805447265, 4149.107941792468, 4178.080822219168, 3626.220362622049, 3646.1796095878744, 3669.3395188865725, 3673.540807399075, 3706.9814650926573, 4298.075913678574, 4301.849435269751, 4307.267764480046, 4307.461567304087, 4351.912961740811, 4765.523447655207, 4834.444038935497, 4860.441049279308, 4870.172070747982, 4956.231784073474, 4256.106217694257, 4279.87160385189, 4280.464941882265, 4284.871453856389, 4318.179545886334, 4381.846635367747, 4405.493368262627, 4408.625266852289, 4432.268675668479, 4435.977820110943, 4612.446506419184, 4646.488886222445, 4722.126406614787, 4727.361806156263, 4760.428748550196, 4953.702777833341, 4954.925676114934, 4956.132676781477, 4970.527799859007, 4988.376452943382, 4733.148033354029, 4733.266343716729, 4733.479317275166, 4744.3357929890535, 4795.352627395257, 4668.136394766979, 4803.279508073817, 4834.178189707828, 4853.975730121468, 4881.707097574157, 4907.484714104968, 4929.408470983505, 4935.580475659609, 4942.233953737176, 4980.352554167935, 4673.0, 4797.136515427256, 4802.447718512416, 4815.662903596714, 4859.441164266154, 4802.8799280018275, 4845.127876982177, 4850.981293928315, 4863.294822250683, 4882.438519570295, 4773.236282194832, 4805.37530121096, 4821.421429428491, 4854.75726213695, 4862.100511405401, 4703.623710103115, 4730.385049943486, 4912.606991440748, 4915.066137433876, 4948.727819969936, 4675.205215113507, 4687.1328804171335, 4690.249560070372, 4715.151272770934, 4760.190767569452], "value": 4542.377661546765, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.4504475703325, 573.1145380387301, 581.8399940016492, 585.9794907178247, 587.0636335045604, 27424.86287568562, 29849.9552515662, 29965.400691986146, 40341.39487907684, 41673.0, 42473.36289955646, 42958.57041429593, 42976.35535466971, 43034.35448468276, 43051.35422968658, 7847.646855891484, 7950.721724739636, 7957.283844453998, 7964.323032542241, 7995.320397766197, 7514.135874374462, 7862.292393684567, 10074.748131296703, 10349.793004139912, 10355.27513074085, 10349.689509314732, 10400.47997600117, 10419.0, 10423.68728938133, 10433.0, 7672.3478504327195, 10296.14669359515, 10341.276110672256, 10360.792784144274, 10369.222308326867, 9907.108360247612, 10310.536025878779, 10323.174146068297, 10646.095081918047, 10661.147108231324, 39446.0, 39594.20811583781, 39756.801215993735, 39761.80119099415, 39779.0, 3073.8770449182007, 3081.4607443697264, 3361.344537815127, 3588.4079126944025, 3747.4940882980723, 29846.403071938657, 29979.25051873699, 30437.543436848464, 30462.54306185409, 31413.37173256522, 3514.121469632592, 3518.6305437928904, 3530.593981692087, 3537.8584856605703, 3618.7285953553587, 267190.0, 267294.0, 267412.0, 267491.0, 267857.0, 54575.0, 55051.724741376034, 55098.17352739712, 55143.72428137834, 55196.17205741917, 33392.0, 34302.313953721285, 34441.0, 36398.09004774902, 36420.45369319462, 15997.28012239452, 16099.275532601061, 16145.192740362934, 16164.838351616334, 16201.675966480605, 10991.890081099087, 11762.235454695418, 12040.277583345027, 12106.273623582612, 12121.696957575954, 18141.7278740819, 18851.151698173617, 18877.52806179829, 18920.33778817762, 18943.715844262348, 6763.5941843489545, 6865.828354291183, 6873.175218973755, 6942.0, 6974.152854328754, 801.4189712458538, 884.1467983396054, 987.1017374189453, 1017.5115944346755, 1025.4616326428536, 27880.72119278822, 28705.28236794097, 28707.0, 28859.0, 29218.0, 975.3032864130685, 975.4293738163112, 984.3503287829998, 994.4033579852031, 1053.5680371047833, 15226.543203703906, 15236.0, 15424.997375170578, 15571.299291531908, 15721.68556628861, 379259.0, 382231.0, 382352.0, 385023.82368969417, 385400.0, 49587.0, 50155.0, 50160.247596286084, 50321.0, 50355.0, 1068.4283908109123, 1123.0678536814587, 1127.81954887216, 1164.2490593567102, 1205.7046023724245, 19421.924920127683, 29312.0, 29517.852410737807, 31243.375132496767, 31454.52818207683, 46915.296270555285, 47515.52484475111, 47525.04949900913, 47547.0, 47652.2852157211, 337462.0, 344017.0, 344132.0, 344320.0, 345734.0, 22419.551608968057, 22929.197478088186, 24843.0, 25514.362140946625, 25571.74428255768, 42432.0, 42498.36252456154, 42591.7870410646, 42643.147137057706, 43248.783756081015, 36373.818130909174, 36696.08259793527, 36779.81610091932, 37157.03791939668, 37251.44122838105, 36972.63027369799, 37502.81248593739, 37541.0, 37695.81152094222, 37951.81024094862, 34344.48483272703, 34627.30745385129, 35205.0, 35229.82385088058, 35375.29249415049, 31627.367452650356, 32688.127318012634, 32942.67057329396, 33335.66664333326, 33583.481238906694, 24952.875235623706, 24955.50088998246, 25273.0, 25480.8725956369, 25790.484190316463], "value": 18146.73508511229, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.5151394104017, 358.87618771523813, 371.9330520506309, 372.4115896882925, 393.0645064745904, 17342.739858902125, 17362.82637173628, 18326.541836454096, 18333.17500712468, 18350.449486515427, 15855.286512106954, 16243.187840607981, 16288.185590720446, 16502.17489125545, 16541.0, 5102.846914592559, 5274.156135018397, 5308.814191503298, 5319.095753721857, 5319.760610772524, 3863.2273545290914, 4053.716239863211, 5239.580833533309, 6055.424734650202, 6367.936320636803, 6375.808725738212, 6408.551401401904, 6408.839779005515, 6437.806865794034, 6444.967775161118, 5370.677759334452, 5655.632383895034, 5663.0655941769555, 5741.569382296345, 5753.338366087912, 3382.96617033829, 5037.974810125926, 5333.573314134898, 5350.224217488442, 5564.0, 12306.938465307705, 12483.812742808865, 12501.687457813627, 14469.348879300456, 20803.895980520152, 1900.1734245603068, 1945.8540609454349, 2102.905369258387, 2139.529303553216, 2401.368800111409, 8912.8663070054, 9335.813283734287, 9859.802803943952, 10417.583296668125, 13967.511137110254, 1536.9692606147926, 1750.3523696232348, 1760.5598600349913, 1787.30295184878, 1849.824266694662, 69260.6536967317, 71087.28912710858, 72051.0, 72118.99999999948, 72591.63704181445, 10162.898371016343, 10238.283320167517, 10323.122534584494, 10654.840177397346, 10895.727606809893, 13912.721745565032, 14026.08830426019, 14029.579112626638, 14029.649258768612, 14031.438742450187, 7250.383717383976, 7260.6732697028765, 7277.745278915212, 7324.816879577947, 7481.102267727799, 6819.0, 6929.1684997799575, 7011.088558487466, 7013.333733295329, 7016.719331226694, 4426.9778651106535, 4462.531434199363, 4509.436320459942, 4510.954890451119, 4562.224421848294, 1627.5524230836616, 1718.218210714122, 1727.7494763259508, 1736.3401907275154, 1796.1917137288012, 714.6241313960867, 853.2363534636589, 862.4480332587149, 870.1776820904184, 899.6311512279934, 17150.0, 17286.740698889527, 17699.646007079788, 17782.733259001125, 18100.27598896056, 874.3879284500874, 877.3288434347729, 893.8301722672671, 909.4543274035658, 924.9732796595773, 9603.183729382941, 9673.806523869483, 9973.451460169761, 10207.183425325957, 10461.110805581611, 276315.0, 281041.0, 283108.0, 387603.0, 399704.0, 77504.0, 81528.0, 81608.59195703984, 84493.57753211194, 85816.0, 926.7405126564438, 952.1097773581723, 974.8294048541619, 979.4172467381896, 979.9559019844124, 16172.0, 16432.342706291616, 16436.0, 16565.91717041407, 17010.914945425688, 39069.0, 39073.41389879211, 39084.413733793444, 39844.40233396559, 39961.60038399695, 48452.273215901085, 52553.21170182374, 54015.0, 54287.72856135694, 54642.0, 7062.788116356517, 7100.644967751695, 7370.557766534025, 7413.962930185315, 7437.367823735043, 9839.85240221383, 10067.848982265125, 10342.586296548054, 10713.35719856811, 11115.22193446451, 4615.953840461552, 4738.763061846825, 6380.72385522888, 9338.766530836783, 9443.905560944302, 9021.729348119567, 9268.768280793034, 9319.487428191514, 9356.06439356059, 9769.0, 9702.272329575451, 9784.364016338915, 10019.849702254327, 10033.598656053677, 10170.135538479017, 7288.416926645961, 7318.597477138808, 7402.703891844266, 7419.406447484296, 7423.777286681408, 7831.647575859214, 9568.856467153137, 9759.707208783748, 9889.608068935324, 10037.247206459399], "value": 8084.402986590488, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1202.7895118354288, 1249.7125661097948, 1323.02096448628, 1675.279629759203, 1689.020368186452, 7034.824129396761, 7380.114386273648, 7458.366038886701, 7472.290132437416, 7485.850282994337, 6408.487321014308, 7016.368526832597, 7163.749268775581, 7220.350168484835, 7487.3635740961945, 2168.2086038595917, 2193.462601662595, 2197.4176843136584, 2199.3731786440867, 2200.7689192634784, 2091.3307741522717, 2128.5636444528914, 2188.157559339658, 2189.386971647933, 2190.7480639726396, 1843.1060935446365, 2124.468882779305, 2192.3094225318973, 2196.286206982729, 2221.244776775896, 2172.1637169689784, 2178.9019494122804, 2196.417949243452, 2200.6698995150778, 2204.9559008819892, 2133.9466513337134, 2142.989285053565, 2144.8069673729283, 2145.753238377591, 2146.6994620753107, 7323.267673232687, 7395.075615548057, 7418.666160022812, 7431.554106753612, 7435.293647103516, 4403.493598236212, 4541.591256786905, 4544.522825103382, 4548.727076375395, 4548.7725613719185, 2798.510260704389, 2854.8572571371346, 2953.394554116401, 2960.1119664100897, 2961.1708721557998, 877.2674816528206, 879.2614204068549, 880.2429910277157, 887.1660638999384, 892.9196372326522, 10057.195424366033, 10098.848517272247, 10147.086762191364, 10194.23543234253, 10207.18342532603, 3991.820368083443, 4118.979405103015, 4204.621584057389, 4252.085801552681, 4264.211120942636, 8419.0, 8486.915130848613, 8491.830163396697, 8509.404341696145, 8509.957450212709, 4528.88677783058, 4547.590716835501, 4548.840790572314, 4549.727016379028, 4552.453705555355, 4027.5368332641533, 4131.97934010334, 4140.0, 4141.668666506672, 4144.44050053245, 3501.7898926064518, 3549.591796943333, 3563.3051554946537, 3606.8196590170387, 3614.1145419372424, 1038.1072277841051, 1169.9356535390466, 1198.5864876617552, 1206.4329765010432, 1206.7888119579038, 623.8783437229787, 770.6763159472923, 844.9197326253995, 861.3152543727751, 873.5413907698509, 4992.875178120504, 5143.12566863634, 5202.817901373433, 5232.136697444879, 5274.918641678447, 823.9382046346548, 844.8310337932315, 859.4787226608992, 861.5562985062697, 885.880406145175, 3594.2452085061905, 3632.4551317302617, 3647.507586475845, 3650.142216579102, 3694.833732482045, 8817.867731984026, 9247.72256832296, 9321.0, 9321.0, 9346.345755797029, 9218.769530761785, 9224.123708247706, 9225.53872306382, 9237.630494780267, 9252.352335336596, 5913.556483263773, 6144.0, 7071.045408869737, 7075.681594328267, 7234.710611575583, 5101.6735648730855, 5218.321618189611, 5268.2624432578705, 5347.652402593974, 5374.946250537445, 8599.484030958163, 8672.609732562176, 8675.089115643019, 8685.174908383693, 8690.34822388336, 8108.635111419882, 8441.746747597583, 8454.746357609281, 8671.869921951049, 8738.169873862227, 6329.936700632935, 6439.484841212598, 6454.386833250834, 6459.321771213955, 6471.255805582418, 7126.679299431435, 7192.136943566806, 7194.352508274281, 7197.964010180125, 7199.208087110518, 6607.636579987954, 6743.494237932273, 6759.121314229119, 6883.070785443901, 6910.861782764216, 6513.609183449008, 6531.281559028408, 6735.764248251287, 6788.321167883172, 6795.150606174228, 6173.536984726074, 6199.969000154971, 6248.094026366242, 6257.1552840367785, 6260.561760676709, 4482.215612267775, 4524.683272170916, 4606.355110284496, 4636.6058884995155, 4658.394408726979, 4449.0, 4483.0, 4493.236149854467, 4591.311303304397, 4616.953830461653], "value": 4033.129081635206, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.73452158535724, 298.11757198691873, 303.3493157177854, 305.7538681361506, 307.7215120316115, 4788.760561971901, 4838.951610483894, 4842.636802239828, 4844.152273352162, 4846.660733748639, 4517.41273634427, 4603.240465323226, 4634.652401069917, 4635.374224479694, 4808.471068182497, 3687.3362794696945, 3691.7600355976774, 3709.6846768024616, 3777.508923839897, 3795.563510196321, 3762.454444105603, 3800.600936901627, 3800.6579407853287, 3812.504374431334, 3813.0657988792786, 3646.6353364663455, 3780.0, 3793.696504279651, 3804.1250512382167, 3804.8287827047848, 3758.8308526116116, 3776.754510956779, 3783.2244389900006, 3805.162864169878, 3806.143617686026, 3339.098443420263, 3348.7655864089525, 3349.380364632551, 3369.107186595554, 3381.898543043713, 4692.530746925314, 4718.197906355927, 4720.811167553294, 4727.409073865767, 4730.503297153784, 4144.937825932613, 4286.614204721559, 4308.535098066673, 4317.69776115672, 4342.348647702838, 4960.528749768766, 4965.329680493123, 4967.50324967504, 4975.402951645826, 4984.925226121611, 3650.361186792301, 3653.1780349421433, 3670.137517683342, 3672.4491326301, 3684.5762737285286, 5001.374828146481, 5230.686158830445, 5234.057869583511, 5244.973775131138, 5270.736463176864, 3570.125319296789, 3582.549067627615, 3590.281943611288, 3591.3356029134693, 3592.7245827731304, 3623.166671665532, 3641.927161456756, 3643.7813731176216, 3651.8904432867057, 3653.209927135684, 4215.283401821697, 4221.662267018631, 4223.965128543527, 4230.344296634026, 4235.174141042467, 4791.448983366888, 5004.599632029429, 5009.499050094962, 5026.843825920059, 5050.72221027847, 1225.4179264849126, 1254.786686263319, 1267.7211013576998, 1271.4659842865833, 1278.2011242973142, 822.3174764945081, 831.9292860106838, 833.3541505333416, 835.1731785532279, 862.857628491292, 4454.821807127679, 4471.128130014616, 4476.619487343547, 4476.955230447654, 4482.148391805546, 5087.211482220262, 5100.923486147711, 5123.641345105882, 5137.743112844343, 5142.688614403303, 4331.956680433218, 4516.683832131719, 4521.344405061248, 4574.6569007323915, 4632.837850675211, 2758.1863350311705, 2759.84820834856, 2771.057840334296, 2772.0, 2788.6235358226786, 4965.82619608312, 4994.225894986283, 4998.875028124326, 5008.824691135793, 5041.59667226621, 5050.696958182521, 5260.815871444481, 5286.784039670897, 5291.708956007379, 5300.932636271857, 4900.607951363882, 4939.75301234944, 4945.381827271591, 4952.2819191217795, 4979.45226025137, 5160.174372100446, 5177.844664660066, 5180.248863914787, 5190.870228244324, 5198.506141916512, 4902.779374928208, 5013.39839219296, 5037.244413338029, 5054.941760235152, 5065.0, 4939.382577177853, 4944.071811993397, 4957.380327459067, 4957.7273249971595, 4968.0, 3609.729270304685, 3610.079429745398, 3624.5106910566737, 3632.3643362412, 3647.1793846385413, 4977.427595826382, 5143.351174145243, 5163.948360516347, 5197.168453047494, 5245.632805703564, 4970.9254361183885, 4983.3621456337805, 5008.949910500848, 5011.123053465702, 5052.444231134498, 4984.0, 4995.550400463976, 5012.122878496321, 5019.472955339636, 5026.4973502649445, 4678.8596342109795, 4772.546608072227, 4779.378680771617, 4887.560119589254, 4896.192128298933, 5011.348524691913, 5032.823851165192, 5033.245013248042, 5035.420926593342, 5054.342935418372, 4942.258661200849, 4961.387549046646, 4966.0, 4970.155073637418, 4976.129177394014], "value": 3790.660327360852, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [611.8164550634809, 667.4626925325115, 678.4504551313437, 679.5039621076611, 679.5752654590879, 11385.544578216872, 12123.636290911276, 12152.635420937386, 12158.392080395977, 12175.086868484856, 12374.443150058247, 12521.0, 12527.0, 12531.310777907234, 12549.937250313758, 622.9190205273308, 760.5854809129011, 763.1529002806866, 786.9763907082797, 791.1732239809413, 780.59019015017, 783.4163548156631, 785.2657764989724, 785.45018487059, 788.2511613966726, 829.0300348592132, 830.1615368477851, 830.3606223208126, 830.7258604660477, 831.3930830493744, 635.0854769132435, 646.4666650013758, 650.8926027205505, 651.7588492257895, 826.3182874128838, 583.1573376471001, 601.8044135655929, 602.0337358539568, 603.5111559636708, 606.3209205689656, 12143.271403715806, 12177.51289948401, 12181.817272740827, 12276.570320038756, 12733.55432559856, 12560.0, 12867.742645147138, 13017.28404937728, 13103.803442948269, 13106.737865242738, 11444.94277528607, 11633.767324653545, 11820.822687659693, 11928.522859085626, 12337.814932776015, 4073.0835561998315, 4075.4498142750645, 4137.54487006429, 4259.0, 4264.25375559279, 62692.37307626956, 62991.37008629947, 63522.7295454093, 63654.0, 63704.0, 10389.636362727268, 10449.738756530995, 10450.0, 10547.208959328082, 10563.207759418074, 18280.360187393377, 18281.542961426072, 18289.542761431072, 18293.54266143357, 18319.633607328044, 6843.692033858489, 6921.238663746984, 6999.09011828459, 7079.716811327489, 7170.569765814068, 3519.0674471265133, 3577.266660334625, 3581.5702115746276, 3687.2809802088873, 3748.7188460865, 2689.9193024209303, 2806.4527417153868, 2811.1144989328295, 2813.85930703464, 2815.5213613685723, 491.3587767962843, 507.6649411388466, 511.9334486516729, 516.5093161496593, 516.8526969813585, 514.4109994056784, 570.6661602962314, 588.9806180831891, 621.5214285000525, 646.6766616691655, 8452.366072544584, 8925.553722313858, 9699.806003879883, 9884.703458896245, 9918.752031199278, 491.3195224613864, 569.8432930943941, 573.4466240078344, 588.5262363797184, 636.6243916089529, 3868.845246190177, 4300.634446072119, 4332.566743325642, 4333.609975102256, 4388.51726310112, 91839.54080229557, 93162.53418732862, 94657.526712366, 96063.51968240253, 97393.0, 83079.0, 84583.0, 85493.57253213819, 85572.0, 85639.57180214184, 44611.77694111509, 49776.75111624419, 73024.63487682528, 73803.0, 74794.25205747981, 8747.781305467413, 9368.156865882103, 9423.481708506099, 9495.050494950727, 9504.19214366759, 39589.40615890821, 44514.3322850151, 46096.539034609224, 46372.30441543312, 47405.76297118492, 57043.0, 64361.0, 64994.675026624565, 65714.0, 65714.34285657082, 11559.768804623693, 11667.708307292385, 11793.174477786473, 11889.0, 11926.940365298118, 12278.508859645513, 12377.62867113988, 12412.62762117138, 12952.093353465167, 13087.934560327138, 12156.574519891761, 12332.691682708004, 12364.381780911099, 12436.626901192978, 12526.686832829253, 12093.818592721293, 12324.445399956845, 12443.564475243324, 12510.499580017062, 12981.415836287579, 12073.335966521574, 12420.441080151235, 12514.43685034194, 12592.0, 12675.93662031684, 10286.331388459726, 10347.63783267582, 10468.528916198942, 10540.10409115203, 10897.073748731129, 10687.412192329497, 10790.329477986746, 10844.349339039683, 10896.346219226873, 10896.509657065293], "value": 6641.391313285771, "unit": "score"}], "name": "dromaeo_css", "value": 6383.61090409709, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 116.0, 114.0, 116.0, 115.0, 115.0, 114.0, 114.0, 114.0, 114.0], "value": 113.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 124.0, 124.0, 181.0, 125.0, 125.0, 150.0, 121.0, 174.0, 127.0], "value": 140.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 163.0, 163.0, 162.0, 160.0, 161.0, 161.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 75.0, 112.0, 76.0, 76.0, 75.0, 74.0, 98.0, 74.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 117.0, 84.0, 85.0, 84.0, 119.0, 88.0, 86.0, 122.0], "value": 95.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 147.0, 147.0, 146.0, 146.0, 147.0, 147.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 72.0, 62.0, 62.0, 62.0, 63.0, 61.0, 62.0, 61.0], "value": 62.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 64.0], "value": 64.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 84.0, 78.0, 78.0, 88.0, 78.0, 78.0, 81.0, 77.0, 83.0], "value": 80.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 135.0, 134.0, 136.0, 124.0, 129.0, 129.0, 128.0, 167.0, 138.0], "value": 135.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 171.0, 163.0, 164.0, 167.0, 169.0, 168.0, 163.0, 163.0, 164.0], "value": 165.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 66.0, 67.0, 66.0, 65.0, 66.0, 64.0, 64.0], "value": 66.0, "unit": "score"}], "name": "kraken", "value": 1525.8999999999999, "alertThreshold": 2.0}]} 17:18:47 INFO - Return code: 0 17:18:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:18:47 INFO - # TBPL SUCCESS # 17:18:47 INFO - Running post-action listener: _resource_record_post_action 17:18:47 INFO - ##### 17:18:47 INFO - ##### Finished run-tests step (success) 17:18:47 INFO - ##### 17:18:47 INFO - Running post-run listener: _resource_record_post_run 17:18:48 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 7901184; Write bytes: 416378880; Read time: 2092; Write time: 368948 17:18:48 INFO - TinderboxPrint: CPU usage
13.0% 17:18:48 INFO - TinderboxPrint: I/O read bytes / time
7,901,184 / 2,092 17:18:48 INFO - TinderboxPrint: I/O write bytes / time
416,378,880 / 368,948 17:18:48 INFO - TinderboxPrint: CPU idle
8,348.2 (87.0%) 17:18:48 INFO - TinderboxPrint: CPU user
1,201.1 (12.5%) 17:18:48 INFO - TinderboxPrint: Swap in / out
0 / 0 17:18:48 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 90296320; Read time: 0; Write time: 92436 17:18:48 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 5709824; Write bytes: 322478080; Read time: 1964; Write time: 269468 17:18:48 INFO - Running post-run listener: _upload_blobber_files 17:18:48 INFO - Blob upload gear active. 17:18:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:18:48 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 17:18:48 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'] 17:18:48 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 17:18:49 INFO - (blobuploader) - INFO - Open directory for files ... 17:18:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:18:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:18:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:18:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:18:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:18:49 INFO - (blobuploader) - INFO - Done attempting. 17:18:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:18:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:18:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:18:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:18:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:18:50 INFO - (blobuploader) - INFO - Done attempting. 17:18:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:18:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:18:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:18:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:18:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:18:53 INFO - (blobuploader) - INFO - Done attempting. 17:18:53 INFO - (blobuploader) - INFO - Iteration through files over. 17:18:53 INFO - Return code: 0 17:18:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:18:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:18:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fa4d66624235d192efce5fdf444657e772b4f96a7a0902d56a597c1895edc78f87b873e67bd2f6a21577082f395cc6421d28f1b0905524d47eb89197cbd336d8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e9986b824b164ffb4a14ef0d1307b1586e0df2ddcf23e872e4e07c7ecd127f5bcd47c64c53b9b37ecb011de9e056a025233e556dd32662a04f52ff466761fa85", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d9cc1d6f841b974ac50b94df9312ef4f2471440dc6fd4e20d7bebcb3fc8c58472beaa5aee4de743806235fcda44d9df54aaffbffaa89f459dbf8bec388d628b6"} 17:18:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:18:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:18:53 INFO - Contents: 17:18:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fa4d66624235d192efce5fdf444657e772b4f96a7a0902d56a597c1895edc78f87b873e67bd2f6a21577082f395cc6421d28f1b0905524d47eb89197cbd336d8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e9986b824b164ffb4a14ef0d1307b1586e0df2ddcf23e872e4e07c7ecd127f5bcd47c64c53b9b37ecb011de9e056a025233e556dd32662a04f52ff466761fa85", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d9cc1d6f841b974ac50b94df9312ef4f2471440dc6fd4e20d7bebcb3fc8c58472beaa5aee4de743806235fcda44d9df54aaffbffaa89f459dbf8bec388d628b6"} 17:18:53 INFO - Running post-run listener: copy_logs_to_upload_dir 17:18:53 INFO - Copying logs to upload dir... 17:18:53 INFO - mkdir: /builds/slave/test/build/upload/logs 17:18:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.231984 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-07-12 17:18:53.588297) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 17:18:53.591812) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1468367311.993454-570373406 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/fa4d66624235d192efce5fdf444657e772b4f96a7a0902d56a597c1895edc78f87b873e67bd2f6a21577082f395cc6421d28f1b0905524d47eb89197cbd336d8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e9986b824b164ffb4a14ef0d1307b1586e0df2ddcf23e872e4e07c7ecd127f5bcd47c64c53b9b37ecb011de9e056a025233e556dd32662a04f52ff466761fa85", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d9cc1d6f841b974ac50b94df9312ef4f2471440dc6fd4e20d7bebcb3fc8c58472beaa5aee4de743806235fcda44d9df54aaffbffaa89f459dbf8bec388d628b6"} build_url:https://queue.taskcluster.net/v1/task/NUyGDrkhQy6FPXt9gPWAQg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011163 build_url: 'https://queue.taskcluster.net/v1/task/NUyGDrkhQy6FPXt9gPWAQg/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/fa4d66624235d192efce5fdf444657e772b4f96a7a0902d56a597c1895edc78f87b873e67bd2f6a21577082f395cc6421d28f1b0905524d47eb89197cbd336d8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e9986b824b164ffb4a14ef0d1307b1586e0df2ddcf23e872e4e07c7ecd127f5bcd47c64c53b9b37ecb011de9e056a025233e556dd32662a04f52ff466761fa85", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d9cc1d6f841b974ac50b94df9312ef4f2471440dc6fd4e20d7bebcb3fc8c58472beaa5aee4de743806235fcda44d9df54aaffbffaa89f459dbf8bec388d628b6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 17:18:53.621325) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 17:18:53.622049) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1468367311.993454-570373406 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004432 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 17:18:53.704636) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 17:18:53.705005) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 17:18:53.705354) ========= ========= Total master_lag: 0.19 =========