builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-049 starttime: 1468277280.56 results: success (0) buildid: 20160711141026 builduid: 57834fe1578344e1a73354074eac1cf8 revision: aa3e75261064c860d29583974df3fef7fd90a15a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-11 15:48:00.557947) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-11 15:48:00.558398) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-11 15:48:00.558724) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-11 15:48:00.573549) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 15:48:00.573828) ========= 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=db7e7c15f3ca076d53731445000001ba-1468277280.281481-1978854944 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-11 15:48:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.7M=0s 2016-07-11 15:48:01 (46.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.108224 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 15:48:00.696065) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 15:48:00.696377) ========= 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=db7e7c15f3ca076d53731445000001ba-1468277280.281481-1978854944 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018955 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 15:48:00.745412) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 15:48:00.745812) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev aa3e75261064c860d29583974df3fef7fd90a15a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev aa3e75261064c860d29583974df3fef7fd90a15a --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=db7e7c15f3ca076d53731445000001ba-1468277280.281481-1978854944 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-11 15:48:01,243 truncating revision to first 12 chars 2016-07-11 15:48:01,244 Setting DEBUG logging. 2016-07-11 15:48:01,244 attempt 1/10 2016-07-11 15:48:01,244 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/aa3e75261064?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-11 15:48:01,570 unpacking tar archive at: fx-team-aa3e75261064/testing/mozharness/ program finished with exit code 0 elapsedTime=0.672673 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 15:48:01.432208) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-11 15:48:01.432766) ========= script_repo_revision: aa3e75261064c860d29583974df3fef7fd90a15a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-11 15:48:01.433245) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-11 15:48:01.433527) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-11 15:48:01.444203) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-11 15:48:01.444513) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db7e7c15f3ca076d53731445000001ba-1468277280.281481-1978854944 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:48:02 INFO - MultiFileLogger online at 20160711 15:48:02 in /builds/slave/test 15:48:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 15:48:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:48:02 INFO - {'append_to_log': False, 15:48:02 INFO - 'base_work_dir': '/builds/slave/test', 15:48:02 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 15:48:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:48:02 INFO - 'branch': 'Fx-Team-Non-PGO', 15:48:02 INFO - 'buildbot_json_path': 'buildprops.json', 15:48:02 INFO - 'config_files': ('talos/linux_config.py',), 15:48:02 INFO - 'default_actions': ('clobber', 15:48:02 INFO - 'read-buildbot-config', 15:48:02 INFO - 'download-and-extract', 15:48:02 INFO - 'populate-webroot', 15:48:02 INFO - 'create-virtualenv', 15:48:02 INFO - 'install', 15:48:02 INFO - 'run-tests'), 15:48:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:48:02 INFO - 'download_minidump_stackwalk': True, 15:48:02 INFO - 'download_symbols': 'ondemand', 15:48:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:48:02 INFO - 'tooltool.py': '/tools/tooltool.py', 15:48:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:48:02 INFO - '/tools/misc-python/virtualenv.py')}, 15:48:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:48:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:48:02 INFO - 'installer_path': 'installer.exe', 15:48:02 INFO - 'log_level': 'info', 15:48:02 INFO - 'log_name': 'talos', 15:48:02 INFO - 'log_to_console': True, 15:48:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:48:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:48:02 INFO - 'opt_config_files': (), 15:48:02 INFO - 'pip_index': False, 15:48:02 INFO - 'sps_profile': False, 15:48:02 INFO - 'sps_profile_interval': 0, 15:48:02 INFO - 'suite': 'dromaeojs', 15:48:02 INFO - 'system_bits': '32', 15:48:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:48:02 INFO - 'title': 'talos-linux64-ix-049', 15:48:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:48:02 INFO - 'use_talos_json': True, 15:48:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:48:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:48:02 INFO - 'work_dir': 'build'} 15:48:02 INFO - ##### 15:48:02 INFO - ##### Running clobber step. 15:48:02 INFO - ##### 15:48:02 INFO - Running pre-action listener: _resource_record_pre_action 15:48:02 INFO - Running main action method: clobber 15:48:02 INFO - rmtree: /builds/slave/test/build 15:48:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:48:03 INFO - Running post-action listener: _resource_record_post_action 15:48:03 INFO - ##### 15:48:03 INFO - ##### Finished clobber step (success) 15:48:03 INFO - ##### 15:48:03 INFO - ##### 15:48:03 INFO - ##### Running read-buildbot-config step. 15:48:03 INFO - ##### 15:48:03 INFO - Running pre-action listener: _resource_record_pre_action 15:48:03 INFO - Running main action method: read_buildbot_config 15:48:03 INFO - Using buildbot properties: 15:48:03 INFO - { 15:48:03 INFO - "project": "", 15:48:03 INFO - "product": "firefox", 15:48:03 INFO - "script_repo_revision": "production", 15:48:03 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 15:48:03 INFO - "repository": "", 15:48:03 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 15:48:03 INFO - "buildid": "20160711141026", 15:48:03 INFO - "pgo_build": "False", 15:48:03 INFO - "basedir": "/builds/slave/test", 15:48:03 INFO - "buildnumber": 1970, 15:48:03 INFO - "slavename": "talos-linux64-ix-049", 15:48:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:48:03 INFO - "platform": "ubuntu64_hw", 15:48:03 INFO - "scheduler": "tests-fx-team-linux64-talos", 15:48:03 INFO - "branch": "fx-team", 15:48:03 INFO - "repo_path": "integration/fx-team", 15:48:03 INFO - "revision": "aa3e75261064c860d29583974df3fef7fd90a15a", 15:48:03 INFO - "stage_platform": "linux64", 15:48:03 INFO - "builduid": "57834fe1578344e1a73354074eac1cf8", 15:48:03 INFO - "slavebuilddir": "test" 15:48:03 INFO - } 15:48:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/QYbo5ZewSzW0uE88oHhbRA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 15:48:03 INFO - Running post-action listener: _resource_record_post_action 15:48:03 INFO - ##### 15:48:03 INFO - ##### Finished read-buildbot-config step (success) 15:48:03 INFO - ##### 15:48:03 INFO - ##### 15:48:03 INFO - ##### Running download-and-extract step. 15:48:03 INFO - ##### 15:48:03 INFO - Running pre-action listener: _resource_record_pre_action 15:48:03 INFO - Running main action method: download_and_extract 15:48:03 INFO - mkdir: /builds/slave/test/build/tests 15:48:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:03 INFO - https://queue.taskcluster.net/v1/task/QYbo5ZewSzW0uE88oHhbRA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:48:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QYbo5ZewSzW0uE88oHhbRA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:48:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QYbo5ZewSzW0uE88oHhbRA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:48:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QYbo5ZewSzW0uE88oHhbRA/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 15:48:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QYbo5ZewSzW0uE88oHhbRA/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 15:48:03 INFO - Downloaded 1361 bytes. 15:48:03 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:48:03 INFO - Using the following test package requirements: 15:48:03 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:48:03 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:48:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:48:03 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:48:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:48:03 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:48:03 INFO - u'jsshell-linux-x86_64.zip'], 15:48:03 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:48:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:48:03 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:48:03 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:48:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:48:03 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:48:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:48:03 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:48:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:48:03 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:48:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:48:03 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:48:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:03 INFO - https://queue.taskcluster.net/v1/task/QYbo5ZewSzW0uE88oHhbRA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:48:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QYbo5ZewSzW0uE88oHhbRA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:48:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QYbo5ZewSzW0uE88oHhbRA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:48:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QYbo5ZewSzW0uE88oHhbRA/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 15:48:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QYbo5ZewSzW0uE88oHhbRA/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 15:48:05 INFO - Downloaded 22700380 bytes. 15:48:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:48:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:48:06 INFO - Return code: 0 15:48:06 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:48: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')]} 15:48:06 INFO - https://queue.taskcluster.net/v1/task/QYbo5ZewSzW0uE88oHhbRA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:48:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QYbo5ZewSzW0uE88oHhbRA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:48:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QYbo5ZewSzW0uE88oHhbRA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:48:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QYbo5ZewSzW0uE88oHhbRA/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 15:48:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QYbo5ZewSzW0uE88oHhbRA/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 15:48:07 INFO - Downloaded 22700380 bytes. 15:48:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:48:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:48:08 INFO - Return code: 0 15:48:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:08 INFO - https://queue.taskcluster.net/v1/task/QYbo5ZewSzW0uE88oHhbRA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:48:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QYbo5ZewSzW0uE88oHhbRA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:48:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QYbo5ZewSzW0uE88oHhbRA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:48:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QYbo5ZewSzW0uE88oHhbRA/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 15:48:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QYbo5ZewSzW0uE88oHhbRA/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 15:48:10 INFO - Downloaded 14403333 bytes. 15:48:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:48:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 15:48:10 INFO - Return code: 0 15:48:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:10 INFO - https://queue.taskcluster.net/v1/task/QYbo5ZewSzW0uE88oHhbRA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:48:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QYbo5ZewSzW0uE88oHhbRA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:48:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QYbo5ZewSzW0uE88oHhbRA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:48:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QYbo5ZewSzW0uE88oHhbRA/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 15:48:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QYbo5ZewSzW0uE88oHhbRA/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 15:48:12 INFO - Downloaded 56651903 bytes. 15:48:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QYbo5ZewSzW0uE88oHhbRA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:48:12 INFO - mkdir: /builds/slave/test/properties 15:48:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:48:12 INFO - Writing to file /builds/slave/test/properties/build_url 15:48:12 INFO - Contents: 15:48:12 INFO - build_url:https://queue.taskcluster.net/v1/task/QYbo5ZewSzW0uE88oHhbRA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:48:13 INFO - Running post-action listener: _resource_record_post_action 15:48:13 INFO - Running post-action listener: set_extra_try_arguments 15:48:13 INFO - ##### 15:48:13 INFO - ##### Finished download-and-extract step (success) 15:48:13 INFO - ##### 15:48:13 INFO - ##### 15:48:13 INFO - ##### Running populate-webroot step. 15:48:13 INFO - ##### 15:48:13 INFO - Running pre-action listener: _resource_record_pre_action 15:48:13 INFO - Running main action method: populate_webroot 15:48:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:48:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:48:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:48:13 INFO - '--tppagecycles', 15:48:13 INFO - '7'], 15:48:13 INFO - 'tests': ['tsvgm']}}, 15:48:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:48:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:48:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:48:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:48:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:48:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:48:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:13 INFO - 'talos_options': ['--disable-e10s'], 15:48:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:48:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:48:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:13 INFO - 'talos_options': ['--disable-e10s'], 15:48:13 INFO - 'tests': ['damp', 'tps']}, 15:48:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:13 INFO - 'tests': ['damp', 'tps']}, 15:48:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:48:13 INFO - 'tests': ['dromaeo_dom']}, 15:48:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:48:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:48:13 INFO - 'tests': ['basic_compositor_video']}, 15:48:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:48:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:48:13 INFO - 'tests': ['a11yr', 15:48:13 INFO - 'ts_paint', 15:48:13 INFO - 'tpaint', 15:48:13 INFO - 'sessionrestore', 15:48:13 INFO - 'sessionrestore_no_auto_restore', 15:48:13 INFO - 'tabpaint']}, 15:48:13 INFO - 'other-e10s': {'tests': ['a11yr', 15:48:13 INFO - 'ts_paint', 15:48:13 INFO - 'tpaint', 15:48:13 INFO - 'sessionrestore', 15:48:13 INFO - 'sessionrestore_no_auto_restore', 15:48:13 INFO - 'tabpaint']}, 15:48:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:48:13 INFO - 'ts_paint', 15:48:13 INFO - 'tpaint', 15:48:13 INFO - 'sessionrestore', 15:48:13 INFO - 'sessionrestore_no_auto_restore', 15:48:13 INFO - 'tabpaint']}, 15:48:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:48:13 INFO - 'ts_paint', 15:48:13 INFO - 'tpaint', 15:48:13 INFO - 'sessionrestore', 15:48:13 INFO - 'sessionrestore_no_auto_restore', 15:48:13 INFO - 'tabpaint']}, 15:48:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:48:13 INFO - 'tests': ['a11yr', 15:48:13 INFO - 'ts_paint', 15:48:13 INFO - 'tpaint', 15:48:13 INFO - 'sessionrestore', 15:48:13 INFO - 'sessionrestore_no_auto_restore', 15:48:13 INFO - 'tabpaint']}, 15:48:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:48:13 INFO - 'tests': ['a11yr', 15:48:13 INFO - 'ts_paint', 15:48:13 INFO - 'tpaint', 15:48:13 INFO - 'sessionrestore', 15:48:13 INFO - 'sessionrestore_no_auto_restore', 15:48:13 INFO - 'tabpaint']}, 15:48:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:48:13 INFO - 'tests': ['tsvgx', 15:48:13 INFO - 'tsvgr_opacity', 15:48:13 INFO - 'tart', 15:48:13 INFO - 'tscrollx', 15:48:13 INFO - 'cart']}, 15:48:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:48:13 INFO - 'tsvgr_opacity', 15:48:13 INFO - 'tart', 15:48:13 INFO - 'tscrollx', 15:48:13 INFO - 'cart']}, 15:48:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:13 INFO - 'talos_options': ['--disable-e10s'], 15:48:13 INFO - 'tests': ['tp5o']}, 15:48:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:13 INFO - 'tests': ['tp5o']}, 15:48:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:13 INFO - 'talos_options': ['--disable-e10s', 15:48:13 INFO - '--xperf_path', 15:48:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:48:13 INFO - 'tests': ['tp5n']}, 15:48:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:13 INFO - 'talos_options': ['--xperf_path', 15:48:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:48:13 INFO - 'tests': ['tp5n']}}, 15:48:13 INFO - 'talos.zip': {'path': '', 15:48:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:48:13 INFO - Running post-action listener: _resource_record_post_action 15:48:13 INFO - ##### 15:48:13 INFO - ##### Finished populate-webroot step (success) 15:48:13 INFO - ##### 15:48:13 INFO - ##### 15:48:13 INFO - ##### Running create-virtualenv step. 15:48:13 INFO - ##### 15:48:13 INFO - Running pre-action listener: _resource_record_pre_action 15:48:13 INFO - Running main action method: create_virtualenv 15:48:13 INFO - Creating virtualenv /builds/slave/test/build/venv 15:48:13 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 15:48:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:48:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:48:13 INFO - Using real prefix '/usr' 15:48:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:48:13 INFO - Installing distribute.............................................................................................................................................................................................done. 15:48:15 INFO - Installing pip.................done. 15:48:15 INFO - Return code: 0 15:48:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:48:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2761030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a22180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a203b0>, '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 0x2a212b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a21740>, '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': 'db7e7c15f3ca076d53731445000001ba-1468277280.281481-1978854944', '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 15:48:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:48:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:48:15 INFO - Using env: {'DISPLAY': ':0', 15:48:15 INFO - 'HOME': '/home/cltbld', 15:48:15 INFO - 'LANG': 'en_US.UTF-8', 15:48:15 INFO - 'LANGUAGE': 'en_US:en', 15:48:15 INFO - 'LOGNAME': 'cltbld', 15:48:15 INFO - 'MAIL': '/var/mail/cltbld', 15:48:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:15 INFO - 'MOZ_NO_REMOTE': '1', 15:48:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:15 INFO - 'NO_EM_RESTART': '1', 15:48:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:15 INFO - 'PWD': '/builds/slave/test', 15:48:15 INFO - 'SHELL': '/bin/bash', 15:48:15 INFO - 'SHLVL': '1', 15:48:15 INFO - 'TERM': 'linux', 15:48:15 INFO - 'TMOUT': '86400', 15:48:15 INFO - 'USER': 'cltbld', 15:48:15 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468277280.281481-1978854944', 15:48:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:15 INFO - '_': '/tools/buildbot/bin/python'} 15:48:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:15 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:48:15 INFO - Cleaning up... 15:48:15 INFO - Return code: 0 15:48:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:48:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2761030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a22180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a203b0>, '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 0x2a212b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a21740>, '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': 'db7e7c15f3ca076d53731445000001ba-1468277280.281481-1978854944', '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 15:48:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:48:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:48:15 INFO - Using env: {'DISPLAY': ':0', 15:48:15 INFO - 'HOME': '/home/cltbld', 15:48:15 INFO - 'LANG': 'en_US.UTF-8', 15:48:15 INFO - 'LANGUAGE': 'en_US:en', 15:48:15 INFO - 'LOGNAME': 'cltbld', 15:48:15 INFO - 'MAIL': '/var/mail/cltbld', 15:48:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:15 INFO - 'MOZ_NO_REMOTE': '1', 15:48:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:15 INFO - 'NO_EM_RESTART': '1', 15:48:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:15 INFO - 'PWD': '/builds/slave/test', 15:48:15 INFO - 'SHELL': '/bin/bash', 15:48:15 INFO - 'SHLVL': '1', 15:48:15 INFO - 'TERM': 'linux', 15:48:15 INFO - 'TMOUT': '86400', 15:48:15 INFO - 'USER': 'cltbld', 15:48:15 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468277280.281481-1978854944', 15:48:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:15 INFO - '_': '/tools/buildbot/bin/python'} 15:48:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:16 INFO - Downloading/unpacking psutil>=3.1.1 15:48:16 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 15:48:16 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 15:48:16 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 15:48:16 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 15:48:16 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 15:48:16 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 15:48:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:48:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:48:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:48:18 INFO - Installing collected packages: psutil 15:48:18 INFO - Running setup.py install for psutil 15:48:18 INFO - building 'psutil._psutil_linux' extension 15:48:18 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 15:48:18 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:48:18 INFO - building 'psutil._psutil_posix' extension 15:48:18 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:48:18 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:48:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:48:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:48:18 INFO - Successfully installed psutil 15:48:18 INFO - Cleaning up... 15:48:18 INFO - Return code: 0 15:48:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:48: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')]} 15:48:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48: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')]} 15:48:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2761030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a22180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a203b0>, '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 0x2a212b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a21740>, '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': 'db7e7c15f3ca076d53731445000001ba-1468277280.281481-1978854944', '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 15:48:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:48:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:48:18 INFO - Using env: {'DISPLAY': ':0', 15:48:18 INFO - 'HOME': '/home/cltbld', 15:48:18 INFO - 'LANG': 'en_US.UTF-8', 15:48:18 INFO - 'LANGUAGE': 'en_US:en', 15:48:18 INFO - 'LOGNAME': 'cltbld', 15:48:18 INFO - 'MAIL': '/var/mail/cltbld', 15:48:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:18 INFO - 'MOZ_NO_REMOTE': '1', 15:48:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:18 INFO - 'NO_EM_RESTART': '1', 15:48:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:18 INFO - 'PWD': '/builds/slave/test', 15:48:18 INFO - 'SHELL': '/bin/bash', 15:48:18 INFO - 'SHLVL': '1', 15:48:18 INFO - 'TERM': 'linux', 15:48:18 INFO - 'TMOUT': '86400', 15:48:18 INFO - 'USER': 'cltbld', 15:48:18 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468277280.281481-1978854944', 15:48:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:18 INFO - '_': '/tools/buildbot/bin/python'} 15:48:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:48:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:48:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:48:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:48:21 INFO - Installing collected packages: mozsystemmonitor 15:48:21 INFO - Running setup.py install for mozsystemmonitor 15:48:21 INFO - Successfully installed mozsystemmonitor 15:48:21 INFO - Cleaning up... 15:48:21 INFO - Return code: 0 15:48:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:48:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:21 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 0x2761030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a22180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a203b0>, '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 0x2a212b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a21740>, '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': 'db7e7c15f3ca076d53731445000001ba-1468277280.281481-1978854944', '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 15:48:21 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 15:48:21 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 15:48:21 INFO - Using env: {'DISPLAY': ':0', 15:48:21 INFO - 'HOME': '/home/cltbld', 15:48:21 INFO - 'LANG': 'en_US.UTF-8', 15:48:21 INFO - 'LANGUAGE': 'en_US:en', 15:48:21 INFO - 'LOGNAME': 'cltbld', 15:48:21 INFO - 'MAIL': '/var/mail/cltbld', 15:48:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:21 INFO - 'MOZ_NO_REMOTE': '1', 15:48:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:21 INFO - 'NO_EM_RESTART': '1', 15:48:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:21 INFO - 'PWD': '/builds/slave/test', 15:48:21 INFO - 'SHELL': '/bin/bash', 15:48:21 INFO - 'SHLVL': '1', 15:48:21 INFO - 'TERM': 'linux', 15:48:21 INFO - 'TMOUT': '86400', 15:48:21 INFO - 'USER': 'cltbld', 15:48:21 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468277280.281481-1978854944', 15:48:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:21 INFO - '_': '/tools/buildbot/bin/python'} 15:48:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:21 INFO - Downloading/unpacking jsonschema==2.5.1 15:48:21 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 15:48:21 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 15:48:21 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 15:48:21 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 15:48:21 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 15:48:21 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 15:48:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:48:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:48:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:23 INFO - Downloading functools32-3.2.3-2.tar.gz 15:48:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:48:23 INFO - warning: no files found matching '*.txt' 15:48:23 INFO - no previously-included directories found matching 'build' 15:48:23 INFO - no previously-included directories found matching 'dist' 15:48:23 INFO - no previously-included directories found matching '.git*' 15:48:23 INFO - Installing collected packages: jsonschema, functools32 15:48:23 INFO - Running setup.py install for functools32 15:48:23 INFO - warning: no files found matching '*.txt' 15:48:23 INFO - no previously-included directories found matching 'build' 15:48:23 INFO - no previously-included directories found matching 'dist' 15:48:23 INFO - no previously-included directories found matching '.git*' 15:48:23 INFO - Successfully installed jsonschema functools32 15:48:23 INFO - Cleaning up... 15:48:23 INFO - Return code: 0 15:48:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:48: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')]} 15:48:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48: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')]} 15:48:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2761030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a22180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a203b0>, '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 0x2a212b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a21740>, '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': 'db7e7c15f3ca076d53731445000001ba-1468277280.281481-1978854944', '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 15:48:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:48:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:48:23 INFO - Using env: {'DISPLAY': ':0', 15:48:23 INFO - 'HOME': '/home/cltbld', 15:48:23 INFO - 'LANG': 'en_US.UTF-8', 15:48:23 INFO - 'LANGUAGE': 'en_US:en', 15:48:23 INFO - 'LOGNAME': 'cltbld', 15:48:23 INFO - 'MAIL': '/var/mail/cltbld', 15:48:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:23 INFO - 'MOZ_NO_REMOTE': '1', 15:48:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:23 INFO - 'NO_EM_RESTART': '1', 15:48:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:23 INFO - 'PWD': '/builds/slave/test', 15:48:23 INFO - 'SHELL': '/bin/bash', 15:48:23 INFO - 'SHLVL': '1', 15:48:23 INFO - 'TERM': 'linux', 15:48:23 INFO - 'TMOUT': '86400', 15:48:23 INFO - 'USER': 'cltbld', 15:48:23 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468277280.281481-1978854944', 15:48:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:23 INFO - '_': '/tools/buildbot/bin/python'} 15:48:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:23 INFO - Downloading/unpacking blobuploader==1.2.4 15:48:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:25 INFO - Downloading blobuploader-1.2.4.tar.gz 15:48:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:48:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:48: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 15:48: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 15:48: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 15:48: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 15:48: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 15:48: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 15:48:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:48:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:48:26 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 15:48:26 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 15:48:26 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 15:48:26 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 15:48:26 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 15:48:26 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 15:48:26 INFO - Downloading docopt-0.6.1.tar.gz 15:48:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:48:26 INFO - Installing collected packages: blobuploader, requests, docopt 15:48:26 INFO - Running setup.py install for blobuploader 15:48:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:48:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:48:26 INFO - Running setup.py install for requests 15:48:27 INFO - Running setup.py install for docopt 15:48:27 INFO - Successfully installed blobuploader requests docopt 15:48:27 INFO - Cleaning up... 15:48:27 INFO - Return code: 0 15:48:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:48:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:27 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 0x2761030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a22180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a203b0>, '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 0x2a212b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a21740>, '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': 'db7e7c15f3ca076d53731445000001ba-1468277280.281481-1978854944', '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 15:48:27 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 15:48:27 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 15:48:27 INFO - Using env: {'DISPLAY': ':0', 15:48:27 INFO - 'HOME': '/home/cltbld', 15:48:27 INFO - 'LANG': 'en_US.UTF-8', 15:48:27 INFO - 'LANGUAGE': 'en_US:en', 15:48:27 INFO - 'LOGNAME': 'cltbld', 15:48:27 INFO - 'MAIL': '/var/mail/cltbld', 15:48:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:27 INFO - 'MOZ_NO_REMOTE': '1', 15:48:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:27 INFO - 'NO_EM_RESTART': '1', 15:48:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:27 INFO - 'PWD': '/builds/slave/test', 15:48:27 INFO - 'SHELL': '/bin/bash', 15:48:27 INFO - 'SHLVL': '1', 15:48:27 INFO - 'TERM': 'linux', 15:48:27 INFO - 'TMOUT': '86400', 15:48:27 INFO - 'USER': 'cltbld', 15:48:27 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468277280.281481-1978854944', 15:48:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:27 INFO - '_': '/tools/buildbot/bin/python'} 15:48:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:48:27 INFO - Running setup.py (path:/tmp/pip-QNNW9J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:48:27 INFO - Running setup.py (path:/tmp/pip-OXP9jM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:48:27 INFO - Running setup.py (path:/tmp/pip-Rvx7Ox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:48:27 INFO - Running setup.py (path:/tmp/pip-zFcBfP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:48:27 INFO - Running setup.py (path:/tmp/pip-aSsRu2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:48:27 INFO - Running setup.py (path:/tmp/pip-rjXS9D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:48:27 INFO - Running setup.py (path:/tmp/pip-l82bZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:48:27 INFO - Running setup.py (path:/tmp/pip-XtwYqo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:48:28 INFO - Running setup.py (path:/tmp/pip-hQImMu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:48:28 INFO - Running setup.py (path:/tmp/pip-05mhLG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:48:28 INFO - Running setup.py (path:/tmp/pip-vY8oEr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:48:28 INFO - Running setup.py (path:/tmp/pip-hRC6vu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:48:28 INFO - Running setup.py (path:/tmp/pip-vVZEx5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:48:28 INFO - Running setup.py (path:/tmp/pip-_9KMue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:48:28 INFO - Running setup.py (path:/tmp/pip-F6q0VC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:48:28 INFO - Running setup.py (path:/tmp/pip-rDjLtl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:48:28 INFO - Running setup.py (path:/tmp/pip-0Cw_d4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:48:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:48:28 INFO - Running setup.py install for manifestparser 15:48:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:48:28 INFO - Running setup.py install for mozcrash 15:48:28 INFO - Running setup.py install for mozdebug 15:48:28 INFO - Running setup.py install for mozdevice 15:48:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:48:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:48:29 INFO - Running setup.py install for mozfile 15:48:29 INFO - Running setup.py install for mozhttpd 15:48:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:48:29 INFO - Running setup.py install for mozinfo 15:48:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:48:29 INFO - Running setup.py install for mozInstall 15:48:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:48:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:48:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:48:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:48:29 INFO - Running setup.py install for mozleak 15:48:29 INFO - Running setup.py install for mozlog 15:48:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:48:29 INFO - Running setup.py install for moznetwork 15:48:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:48:29 INFO - Running setup.py install for mozprocess 15:48:29 INFO - Running setup.py install for mozprofile 15:48:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:48:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:48:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:48:30 INFO - Running setup.py install for mozrunner 15:48:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:48:30 INFO - Running setup.py install for mozscreenshot 15:48:30 INFO - Running setup.py install for moztest 15:48:30 INFO - Running setup.py install for mozversion 15:48:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:48:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:48:30 INFO - Cleaning up... 15:48:30 INFO - Return code: 0 15:48:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:48:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2761030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a22180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a203b0>, '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 0x2a212b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a21740>, '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': 'db7e7c15f3ca076d53731445000001ba-1468277280.281481-1978854944', '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 15:48:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:48:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:48:30 INFO - Using env: {'DISPLAY': ':0', 15:48:30 INFO - 'HOME': '/home/cltbld', 15:48:30 INFO - 'LANG': 'en_US.UTF-8', 15:48:30 INFO - 'LANGUAGE': 'en_US:en', 15:48:30 INFO - 'LOGNAME': 'cltbld', 15:48:30 INFO - 'MAIL': '/var/mail/cltbld', 15:48:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:30 INFO - 'MOZ_NO_REMOTE': '1', 15:48:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:30 INFO - 'NO_EM_RESTART': '1', 15:48:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:30 INFO - 'PWD': '/builds/slave/test', 15:48:30 INFO - 'SHELL': '/bin/bash', 15:48:30 INFO - 'SHLVL': '1', 15:48:30 INFO - 'TERM': 'linux', 15:48:30 INFO - 'TMOUT': '86400', 15:48:30 INFO - 'USER': 'cltbld', 15:48:30 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468277280.281481-1978854944', 15:48:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:30 INFO - '_': '/tools/buildbot/bin/python'} 15:48:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:48:30 INFO - Running setup.py (path:/tmp/pip-OWSvNP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:48:30 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:48:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:48:30 INFO - Running setup.py (path:/tmp/pip-MXFPq2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:48:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:48:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:48:30 INFO - Running setup.py (path:/tmp/pip-pyjn5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:48:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:48:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:48:30 INFO - Running setup.py (path:/tmp/pip-iycSPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:48:31 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)) 15:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:48:31 INFO - Running setup.py (path:/tmp/pip-qkoFdH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:48:31 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)) 15:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:48:31 INFO - Running setup.py (path:/tmp/pip-Bzy2rL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:48:31 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)) 15:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:48:31 INFO - Running setup.py (path:/tmp/pip-dBVHSr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:48:31 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)) 15:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:48:31 INFO - Running setup.py (path:/tmp/pip-sfNAw6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:48:31 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)) 15:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:48:31 INFO - Running setup.py (path:/tmp/pip-YlZQqh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:48:31 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)) 15:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:48:31 INFO - Running setup.py (path:/tmp/pip-d4HL7d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:48:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:48:31 INFO - Running setup.py (path:/tmp/pip-oQCpNF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:48:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:48:31 INFO - Running setup.py (path:/tmp/pip-IAY0wl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:48:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:48:31 INFO - Running setup.py (path:/tmp/pip-vYnOH7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:48:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:48:31 INFO - Running setup.py (path:/tmp/pip-yF0VSI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:48:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:48:31 INFO - Running setup.py (path:/tmp/pip-IDsa_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:48:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:48:31 INFO - Running setup.py (path:/tmp/pip-0YzoUH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:48:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:48:31 INFO - Running setup.py (path:/tmp/pip-GZPOAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:48:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:48:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:48:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:48:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:48:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:48:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:48:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:48: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 15:48: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 15:48: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 15:48: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 15:48: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 15:48: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 15:48:33 INFO - Downloading blessings-1.6.tar.gz 15:48:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:48:33 INFO - Installing collected packages: blessings 15:48:33 INFO - Running setup.py install for blessings 15:48:34 INFO - Successfully installed blessings 15:48:34 INFO - Cleaning up... 15:48:34 INFO - Return code: 0 15:48:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:48:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:48:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:48:34 INFO - Reading from file tmpfile_stdout 15:48:34 INFO - Current package versions: 15:48:34 INFO - argparse == 1.2.1 15:48:34 INFO - blessings == 1.6 15:48:34 INFO - blobuploader == 1.2.4 15:48:34 INFO - docopt == 0.6.1 15:48:34 INFO - functools32 == 3.2.3-2 15:48:34 INFO - jsonschema == 2.5.1 15:48:34 INFO - manifestparser == 1.1 15:48:34 INFO - mozInstall == 1.12 15:48:34 INFO - mozcrash == 0.17 15:48:34 INFO - mozdebug == 0.1 15:48:34 INFO - mozdevice == 0.48 15:48:34 INFO - mozfile == 1.2 15:48:34 INFO - mozhttpd == 0.7 15:48:34 INFO - mozinfo == 0.9 15:48:34 INFO - mozleak == 0.1 15:48:34 INFO - mozlog == 3.2 15:48:34 INFO - moznetwork == 0.27 15:48:34 INFO - mozprocess == 0.23 15:48:34 INFO - mozprofile == 0.28 15:48:34 INFO - mozrunner == 6.12 15:48:34 INFO - mozscreenshot == 0.1 15:48:34 INFO - mozsystemmonitor == 0.3 15:48:34 INFO - moztest == 0.7 15:48:34 INFO - mozversion == 1.4 15:48:34 INFO - psutil == 3.1.1 15:48:34 INFO - requests == 1.2.3 15:48:34 INFO - wsgiref == 0.1.2 15:48:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:48:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:34 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 0x2761030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a22180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a203b0>, '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 0x2a212b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a21740>, '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': 'db7e7c15f3ca076d53731445000001ba-1468277280.281481-1978854944', '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 15:48:34 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 15:48:34 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 15:48:34 INFO - Using env: {'DISPLAY': ':0', 15:48:34 INFO - 'HOME': '/home/cltbld', 15:48:34 INFO - 'LANG': 'en_US.UTF-8', 15:48:34 INFO - 'LANGUAGE': 'en_US:en', 15:48:34 INFO - 'LOGNAME': 'cltbld', 15:48:34 INFO - 'MAIL': '/var/mail/cltbld', 15:48:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:34 INFO - 'MOZ_NO_REMOTE': '1', 15:48:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:34 INFO - 'NO_EM_RESTART': '1', 15:48:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:34 INFO - 'PWD': '/builds/slave/test', 15:48:34 INFO - 'SHELL': '/bin/bash', 15:48:34 INFO - 'SHLVL': '1', 15:48:34 INFO - 'TERM': 'linux', 15:48:34 INFO - 'TMOUT': '86400', 15:48:34 INFO - 'USER': 'cltbld', 15:48:34 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468277280.281481-1978854944', 15:48:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:34 INFO - '_': '/tools/buildbot/bin/python'} 15:48:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:48:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:48:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:48:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:48:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:48:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:48:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:48:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:48:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:48:34 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:48:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:48:34 INFO - Cleaning up... 15:48:34 INFO - Return code: 0 15:48:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:48:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2761030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a22180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a203b0>, '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 0x2a212b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a21740>, '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': 'db7e7c15f3ca076d53731445000001ba-1468277280.281481-1978854944', '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 15:48:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:48:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:48:34 INFO - Using env: {'DISPLAY': ':0', 15:48:34 INFO - 'HOME': '/home/cltbld', 15:48:34 INFO - 'LANG': 'en_US.UTF-8', 15:48:34 INFO - 'LANGUAGE': 'en_US:en', 15:48:34 INFO - 'LOGNAME': 'cltbld', 15:48:34 INFO - 'MAIL': '/var/mail/cltbld', 15:48:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:34 INFO - 'MOZ_NO_REMOTE': '1', 15:48:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:34 INFO - 'NO_EM_RESTART': '1', 15:48:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:34 INFO - 'PWD': '/builds/slave/test', 15:48:34 INFO - 'SHELL': '/bin/bash', 15:48:34 INFO - 'SHLVL': '1', 15:48:34 INFO - 'TERM': 'linux', 15:48:34 INFO - 'TMOUT': '86400', 15:48:34 INFO - 'USER': 'cltbld', 15:48:34 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468277280.281481-1978854944', 15:48:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:34 INFO - '_': '/tools/buildbot/bin/python'} 15:48:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:48:34 INFO - Cleaning up... 15:48:34 INFO - Return code: 0 15:48:34 INFO - Running post-action listener: _resource_record_post_action 15:48:34 INFO - Running post-action listener: _start_resource_monitoring 15:48:34 INFO - Starting resource monitoring. 15:48:34 INFO - ##### 15:48:34 INFO - ##### Finished create-virtualenv step (success) 15:48:34 INFO - ##### 15:48:34 INFO - ##### 15:48:34 INFO - ##### Running install step. 15:48:34 INFO - ##### 15:48:34 INFO - Running pre-action listener: _resource_record_pre_action 15:48:34 INFO - Running main action method: install 15:48:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:48:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:48:34 INFO - Reading from file tmpfile_stdout 15:48:34 INFO - Detecting whether we're running mozinstall >=1.0... 15:48:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:48:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:48:35 INFO - Reading from file tmpfile_stdout 15:48:35 INFO - Output received: 15:48:35 INFO - Usage: mozinstall [options] installer 15:48:35 INFO - Options: 15:48:35 INFO - -h, --help show this help message and exit 15:48:35 INFO - -d DEST, --destination=DEST 15:48:35 INFO - Directory to install application into. [default: 15:48:35 INFO - "/builds/slave/test"] 15:48:35 INFO - --app=APP Application being installed. [default: firefox] 15:48:35 INFO - mkdir: /builds/slave/test/build/application 15:48:35 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'] 15:48:35 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 15:48:51 INFO - Reading from file tmpfile_stdout 15:48:51 INFO - Output received: 15:48:51 INFO - /builds/slave/test/build/application/firefox/firefox 15:48:51 INFO - Running post-action listener: _resource_record_post_action 15:48:51 INFO - ##### 15:48:51 INFO - ##### Finished install step (success) 15:48:51 INFO - ##### 15:48:51 INFO - ##### 15:48:51 INFO - ##### Running run-tests step. 15:48:51 INFO - ##### 15:48:51 INFO - Running pre-action listener: _resource_record_pre_action 15:48:51 INFO - Running main action method: run_tests 15:48:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:48:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:48:51 INFO - Python 2.7.3 15:48:51 INFO - Return code: 0 15:48:51 INFO - grabbing minidump binary from tooltool 15:48:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:51 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a203b0>, '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 0x2a212b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a21740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:48:51 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:48:51 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:48:51 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 15:48:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:48:51 INFO - Return code: 0 15:48:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:48:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:48:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:48:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:48:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:48:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QYbo5ZewSzW0uE88oHhbRA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 15:48:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QYbo5ZewSzW0uE88oHhbRA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-049 --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 15:48:51 INFO - Using env: {'DISPLAY': ':0', 15:48:51 INFO - 'HOME': '/home/cltbld', 15:48:51 INFO - 'LANG': 'en_US.UTF-8', 15:48:51 INFO - 'LANGUAGE': 'en_US:en', 15:48:51 INFO - 'LOGNAME': 'cltbld', 15:48:51 INFO - 'MAIL': '/var/mail/cltbld', 15:48:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:48:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:48:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:51 INFO - 'MOZ_NO_REMOTE': '1', 15:48:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:48:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:51 INFO - 'NO_EM_RESTART': '1', 15:48:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:51 INFO - 'PWD': '/builds/slave/test', 15:48:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:48:51 INFO - 'SHELL': '/bin/bash', 15:48:51 INFO - 'SHLVL': '1', 15:48:51 INFO - 'TERM': 'linux', 15:48:51 INFO - 'TMOUT': '86400', 15:48:51 INFO - 'USER': 'cltbld', 15:48:51 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468277280.281481-1978854944', 15:48:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:51 INFO - '_': '/tools/buildbot/bin/python'} 15:48:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QYbo5ZewSzW0uE88oHhbRA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 15:48:51 INFO - mozversion application_buildid: 20160711141026 15:48:51 INFO - mozversion application_changeset: aa3e75261064c860d29583974df3fef7fd90a15a 15:48:51 INFO - mozversion application_display_name: Nightly 15:48:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:48:51 INFO - mozversion application_name: Firefox 15:48:51 INFO - mozversion application_remotingname: firefox 15:48:51 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:48:51 INFO - mozversion application_vendor: Mozilla 15:48:51 INFO - mozversion application_version: 50.0a1 15:48:51 INFO - mozversion platform_buildid: 20160711141026 15:48:51 INFO - mozversion platform_changeset: aa3e75261064c860d29583974df3fef7fd90a15a 15:48:51 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:48:51 INFO - mozversion platform_version: 50.0a1 15:48:51 INFO - using testdate: 1468277331 15:48:51 INFO - actual date: 1468277331 15:48:51 INFO - starting webserver on 'localhost:59732' 15:48:51 INFO - SUITE-START | Running 2 tests 15:48:51 INFO - TEST-START | dromaeo_css 15:48:51 INFO - operating with platform_type : linux_ 15:48:51 INFO - Initialising browser for dromaeo_css test... 15:48:51 INFO - TEST-INFO | started process 18399 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9cbohV/profile http://localhost:59732/getInfo.html) 15:48:56 INFO - PROCESS | 18399 | __metrics Screen width/height:1600/1200 15:48:56 INFO - PROCESS | 18399 | colorDepth:24 15:48:56 INFO - PROCESS | 18399 | Browser inner width/height: 1024/697 15:48:56 INFO - PROCESS | 18399 | __metrics 15:48:56 INFO - PROCESS | 18399 | 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" 15:48:56 INFO - PROCESS | 18399 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:48:57 INFO - TEST-INFO | 18399: exit 0 15:48:57 INFO - Browser initialized. 15:48:57 INFO - Running cycle 1/1 for dromaeo_css test... 15:48:57 INFO - TEST-INFO | started process 18483 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9cbohV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:49:09 INFO - PROCESS | 18483 | RSS: Main: 158855168 15:49:09 INFO - PROCESS | 18483 | 15:50:00 INFO - PROCESS | 18483 | 1468277400900 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] 15:52:13 INFO - PROCESS | 18483 | Cycle 1(1): loaded http://localhost:59732/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59732/tests/dromaeo/cssquery-ext.html) 15:52:14 INFO - PROCESS | 18483 | RSS: Main: 237727744 15:52:14 INFO - PROCESS | 18483 | 15:55:17 INFO - PROCESS | 18483 | Cycle 1(1): loaded http://localhost:59732/tests/dromaeo/cssquery-ext.html (next: http://localhost:59732/tests/dromaeo/cssquery-jquery.html) 15:55:18 INFO - PROCESS | 18483 | RSS: Main: 241840128 15:55:18 INFO - PROCESS | 18483 | 15:58:20 INFO - PROCESS | 18483 | Cycle 1(1): loaded http://localhost:59732/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59732/tests/dromaeo/cssquery-mootools.html) 15:58:21 INFO - PROCESS | 18483 | RSS: Main: 245309440 15:58:21 INFO - PROCESS | 18483 | 16:01:23 INFO - PROCESS | 18483 | Cycle 1(1): loaded http://localhost:59732/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59732/tests/dromaeo/cssquery-prototype.html) 16:01:23 INFO - PROCESS | 18483 | RSS: Main: 250032128 16:01:23 INFO - PROCESS | 18483 | 16:04:26 INFO - PROCESS | 18483 | Cycle 1(1): loaded http://localhost:59732/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59732/tests/dromaeo/cssquery-yui.html) 16:04:27 INFO - PROCESS | 18483 | RSS: Main: 223150080 16:04:27 INFO - PROCESS | 18483 | 16:07:30 INFO - PROCESS | 18483 | Cycle 1(1): loaded http://localhost:59732/tests/dromaeo/cssquery-yui.html (next: http://localhost:59732/tests/dromaeo/cssquery-dojo.html) 16:07:30 INFO - PROCESS | 18483 | RSS: Main: 283459584 16:07:30 INFO - PROCESS | 18483 | 16:07:30 INFO - PROCESS | 18483 | __start_tp_report 16:07:30 INFO - PROCESS | 18483 | _x_x_mozilla_page_load 16:07:30 INFO - PROCESS | 18483 | _x_x_mozilla_page_load_details 16:07:30 INFO - PROCESS | 18483 | |i|pagename|runs| 16:07:30 INFO - PROCESS | 18483 | |0;dojo.html;2614.895404183833;2629.7633213010827;2651.217890722237;2668.3195785074804;2669.2926374510757;4643.349931009661;4710.6938049026785;4734.274558117812;4810.134175848341;4865.270209468577;4780.737059461728;4807.903841923159;4808.966072294456;4812.205986012304;4824.855254342367;4205.621494065534;4353.825846966118;4435.775537386323;4488.685791994561;4563.885902852422;4457.465104187502;4492.528284530126;4516.954830451703;4520.68355215135;4549.021960278539;4042.858499952517;4273.786310684453;4309.784510774449;4320.740755554645;4351.586599273064;4352.151330490556;4365.083332500179;4383.495897971742;4416.227160246944;4444.911101777979;4404.69167158299;4422.071365013351;4422.5577442255835;4464.776761161929;4470.731756094645;4681.695689780154;4741.525847415265;4800.399950006249;4810.06203790261;4818.277258411266;5158.4067832199025;5207.817726379596;5211.609129315279;5213.713245771481;5227;5222.4255331913455;5252;5258.3689957205;5259.237410575445;5259.947400525984;4726.503717109688;4750.8337208197545;4763.428388593322;4770.0221454602415;4856.902861942742;5278.445763194886;5313.442088580643;5313.973430132902;5319.175527793198;5320.467953204726;4884.535969082932;5039.546440820343;5055.292259083732;5107.642465027412;5108.9744551277745;5063.291139240509;5105.642605017613;5111.846644600668;5112.565431938253;5136.8202112925865;5079.238114282887;5088.92366614501;5089.847304580869;5090.821821236239;5136.871578210575;4935.087008903364;5022.397312322471;5059.696418214919;5071.0872043032605;5071.923921141186;4420.491643461043;4427.8228870844805;4437.955620443819;4481.305397663367;4484.484284307281;3816.7328287020196;3834.1564855731694;3846.1730727893637;3857.556381016163;3882.4176373544196;4312.288472402081;4341.175176716414;4451.732896026184;4486.439195100613;4494.348319493655;5103.617228707862;5156.278121063054;5161.406438259573;5165.070287348313;5183.481651834786;4453.332000199931;4455.598996090367;4457.108578284357;4457.153140903218;4499.77501124949;4509.143262780061;4609.354690343354;4667.019925815617;4667.043256132485;4707.458642256116;4868.586170175575;4879.853604391874;4902.60779137661;4923.901521969612;4956.405231372259;5194.8961020780125;5212.035773381785;5216.921746173734;5220.477952204901;5270.736463176902;4678.345031695633;4739.4075740532435;4771.66598338113;4854.2233242681;4920.335754673217;5014.34813474246;5040.269160971565;5047.520485553867;5055.87360315995;5085.821996230115;5077.543021128116;5084.618653600921;5093.032323858455;5099.974500127476;5123.205903085028;4859.392575928009;4956.3804524434445;4997.300377947017;5057.74711264428;5070.239464080418;5059.848204553869;5070.949290507047;5071.061853557104;5071.315372424676;5108.693478391308;4962.801487940442;4985.152524070989;4987.401511818605;5029.9245511318095;5034.546890779848;4795.040991801584;4958.752062396938;5003.574696150868;5015.272785446163;5019.799208031784;4873.658843880894;4899.608031357411;4906.754662266943;4912.066707325596;4952.8761780955765 16:07:30 INFO - PROCESS | 18483 | |1;ext.html;567.6395488864571;573.7475510775256;579.2787978966188;581.4505292498591;583.643977173924;26822.5976610351;29784.702152978465;29813.552796708067;40624.39063414051;41890.37164442528;42098.36852447216;42426.57573424265;42516.36225456621;42517.362239566355;42573.14853702924;7876.369890408782;8005.919940800605;8025.6789728410795;8026.719064832732;8043.075046369655;7503.662335194929;7698.307152356287;7709.922900771005;7842.607869606497;7911.327537159348;10152.949235253813;10443.582256709722;10473.057424831764;10822.837657435144;10825.458727063655;10308.536115874766;10386.740331491697;10391.48042597867;10397.272190946636;10398.116160126398;7442.144153422371;7686.615669216517;7694.115176754689;10196;10268.178545716324;37613.81193094044;38781.03047423837;38886;41972.58027419717;42135.789321053504;2409.771071748181;2460.6309053641917;2468.5926822074334;3028.712272334125;3029.1972627253795;27454.5881811773;30184.24539386511;30510.237244068852;30634.84682576595;30734.538981915288;3353.4131526982924;3359.5128706337446;3364.814935178564;3393.6436674149354;3400.1159698478327;280268;288021.9999999979;289317;289608;290749;49234;58580;60812;63640.36359636437;63698.68150659217;61174.38825611776;61357.69321153365;61725;61757.69121154455;61798.38201617926;14984.70030599382;15129.621759456102;15154.924225378803;15169.24153792306;15235;11495.252808567417;11570.76858462826;11580.073594112619;11608.361540115206;11695.070313398364;16545.172741362883;18885.15016824246;19207.61584768297;19258.133383997752;19493.610127797365;7224.906440959111;7247.565146091146;7248.60132692707;7661.502002369828;7686.423518236154;703.2334755116947;782.0537150048391;868.5440143924491;869.9043105258417;872.289084396215;25117.160235317726;25708.871455642602;26236.344091397485;26364;26400.339991499983;856.8629019356997;859.3984211052289;873.9038705742363;888.9377743558018;901.8151278987792;13406.597802065953;13595.932020339835;13793.448262069405;13817.240051797247;13871.306434678225;386385;391354;392174;392646;393130;49527.25709114366;49987.25019124716;50022.49977500179;50136.498635013915;50197.49802502001;1070.6573896353093;1075.6074032977906;1090.9399983000853;1135.761490087091;1174.6417342710556;26949.191524254304;28972.855135724185;29622;30137.849310753307;30292.697073028987;42389.78805106078;42762.35856462093;42880;42957.14085718331;43075.784621076695;294675;296342;296451.6241931522;296877;297765;32392;38178.618213817506;42305.5769442314;42358.78820605877;42492.15015699607;42879.57120428756;43744.12511749811;43985.78007109944;44659.553404465536;44728.55271447244;37001.07497312481;37115;37296.62703372932;37594.24811503809;37643;37524.437133443564;37567.248655027295;37744.433833493065;38033.42949855699;38093.4285985716;37168.814155929045;38111;38530.80734596309;39464.60535394724;40005;31234;33825.830870845486;33851.66148338485;33866;34016;24914.750852491245;26150.34624134336;26330.73669263283;27708.30729231785;27953.440931180856 16:07:30 INFO - PROCESS | 18483 | |2;jquery.html;344.63352806123714;363.30608537693;363.8762820640983;364.79389145132996;379.1818231579576;12979.610611681654;13993.790093148611;14743.483978060756;17511.912440437813;17566;16249.268782904768;16398.26207820648;16748.078855662934;16756.916215418936;16819.747703784422;4868.805247790093;5043.218301163325;5043.596512279028;5045.21799121135;5048.040872234282;3668.3580373434543;5635.239242702224;5932.940670593303;5943.613665111776;6044.7279872405625;5213.452587478317;5965.433283838051;5982.401759824026;6004.489618382443;6006.969965150168;5458.153986132156;5554.2779438672715;5574.804881829116;5580.386157522669;5580.553555715554;5303.814366497193;5358.705271210082;5399.62202645815;5408.188771684239;5488.4785945335125;20038.398848034583;20456.079476423598;20875.5824883503;20965.790342096538;20971.685424718642;1893.848492120627;1906.761654793151;1911.2068491575978;2188.8248940084754;2219.4673278413225;9222.40054396462;9258.490783006931;9316.02181770918;9428.575714092882;9634.229261659051;1705.309349713368;1774.6007148391639;1778.8932664040199;1786.4457921608155;1818.818118188184;49708.50291497075;65467.3453265466;68203.31796682019;68725.65637171832;70266.297337027;9678.56446459911;9786.41281523111;9897.455639939872;10013.949930250303;10088.546015429323;13579.728405431835;13661.658458538615;13663.248521331423;13682.794758078637;13695.178289302674;7097.325754053357;7101.183363913216;7184.389326907167;7233.674484648203;7299.489035767445;6824.283450237753;6949.652517374111;6962.965185174042;7088.7518936838;7089;4328.350747387917;4351.325544540601;4399.978000110043;4420.204363214652;4487.618552423015;1819.6087841114224;1834.3488061738158;1854.7588813454165;1864.7296142059326;1871.8970456625016;843.5908584336592;865.7662431143556;874.8381549413378;883.2139395937621;934.7709811096325;16669.3332266708;17430.215640296217;17456;17474.213660385314;17794.288228470974;870.5821205821242;881.6914080072052;883.960221790021;914.4650379527918;924.1082355526949;9109.407888487227;9326.95336523313;9423.19902808269;9504.144626983467;9744.853827192597;383225;387041;394844;395727;395802;72617;84474;86716.56641716752;87748;89007;845.4335595151264;913.48388160689;936.194872409727;959.0888655777039;963.4604621412032;15850.207489625704;15913;16184.757228641345;16312.265948032129;16598.75101873497;29555.113346599635;36965.63034369622;39216.66658334074;40407.59592404156;40841.38737918993;49546.752266238436;51071.74464127656;53788.193177101595;55259.44740552543;56228;7172.964135179291;7353.411727061715;7366.263373662805;7380.741674041383;7481.925180748123;6030.4572588467245;7046.682899269443;9285.885693716797;10421.426821524889;10617.522211500656;9558.28312876551;9572;9649.9035009649;9703.107893960892;9821.901780982385;9238.676646317346;9358.812823743623;9362.765930851783;9485.193758530602;9578.377405468622;9675.419474831533;9682.886468056264;9888.851667224853;9955.850662240216;10093.949530252596;7001.719931202695;7224.13310402755;7225.963870180825;7352.5220860643885;7488.850222995618;7156.320149585781;9398.154166125081;9776.169025632616;9807.215422766305;10096.29325947206 16:07:30 INFO - PROCESS | 18483 | |3;mootools.html;1351.2095424176855;1415.1933397963162;1463.9414423423063;1676.1954261954254;1686.6542358816444;7040.859182816341;7465.104187497494;7539.472236943416;7543.622818859056;7545.660445279955;6424.486041116711;7142.96428517858;7286.52637578557;7288.890666640004;7438.218987006368;2177.1617927098023;2205.018766648842;2207.0840601150503;2208.3043841190056;2209.823214142865;2171.381156370435;2184.759676435591;2225.410266279429;2226.554689062186;2228.1644383356243;1895.962080758384;2116.841236907238;2181.3564998325533;2182.454386403399;2189.069645400706;2184.8907554622365;2197.9890100549555;2203.1627981367137;2224.0547767199037;2226.5101677630896;2127.489402543394;2160.686700428445;2162.1135334512774;2162.91348346066;2164.350694791556;7411.592362420065;7426.554406735613;7446.255374462565;7481.326680598718;7483.1020277566495;4335.414719012924;4454.77726113693;4462.687611867171;4463.509014008457;4479.104179164147;2799.720027997184;2856.3002064494126;2929.2530404746867;2941.57347184657;2946.0719873240073;943.688582767685;961.7787908780949;972.7665360313545;974.605284859633;980.5636491761169;9805.705828825146;9840.65557705477;9844.458554779412;9844.753881153028;9850.458224797634;3890.8638197663513;4056.5943405659787;4154.605312495308;4157.812898419578;4190.895227619273;8489.95755021221;8526;8600.5699715014;8614.827703445895;8625.309975201968;4603.815847366135;4606.424196975378;4606.447226332794;4607.424071991001;4613.192691279013;4102.138550904284;4164.7917604119675;4235.385869048971;4235.851745188904;4237.5762423758;3434.1929646533044;3438.862445502202;3475.3223121491064;3499.545059142295;3532.3994920863515;1003.6838395905412;1141.9543218271342;1143.5654451308617;1165.1377980294521;1166.8949794518535;790.2650535002502;808.7533302342724;827.4952279109739;871.5293741379711;883.262475832687;4855.830045948375;5124.820631277962;5177.223416487557;5209.244659524424;5234.241035049897;835.4360806455618;855.1363123245443;881.2729498163912;888.1030159538783;902.873597696323;3412.931741365159;3422.486627005919;3452.1197094740683;3484.564429446319;3511;8897.777555561033;9206.447613143233;9273.768155796024;9286.860697089549;9295.11696388842;7745.496542724705;8563.400561960727;8976;9239.491827949527;9252.49111298885;6657.567258128303;6815.250322464426;6824.727010919508;6837.213720422115;6838.658067096625;5067.113255180402;5136.717480538607;5263.815766448156;5291.153415453509;5320;8321.126281740571;8325.625346859284;8367.163283671583;8424.073351931405;8430.831383372175;8158.265756081981;8664.220220179963;8676.349273804364;8680.869786953075;8697.52163630981;6195.907061393992;6338.778142765165;6347.079673447232;6351.047342898602;6356.745730170742;7164.462665300019;7211.062561867134;7225.530340527849;7239.493235473677;7241.5293005954445;6467.417932386108;6551.50863685216;6562.967185164043;6611.735530578915;6631.403173714389;6014.27828660546;6117.785877494266;6130.50955923534;6205.689715514297;6209.130721699056;5737.655740655574;5746.9712651436475;5803.622764520293;5805.3033635962265;5806.883862322646;4336.436263285753;4380.211561918885;4404.801783919667;4405.622848526338;4437.5784300491405;4358.607725304738;4389.824407023811;4395.230834603995;4421.336799480104;4432.202203603253 16:07:30 INFO - PROCESS | 18483 | |4;prototype.html;294.27020987949885;294.41705423261936;302.30319114441215;302.65799646399563;303.743336880336;4855.927161092582;4882.5596449047525;4946.18387965986;4947.579455746266;4965.776540055697;4830.951690483094;4831;4880.316755654211;4886.48691887352;4887.7311747853855;3614.3855544557355;3726.142987112966;3752.774833509998;3858.266929283441;3904.726669133162;3841.1165431950667;3858.977370996688;3863.6624841970483;3871.399933010388;3895.1235971906376;3640.7451478396524;3827.5598306194865;3833.5974722654137;3838.6161383861668;3839.6352346527037;3719.8140092995377;3827.674647654953;3832.3868181090893;3835.9232815343817;3855.3253180693405;3397.3205358928067;3414.6756058174433;3414.778039427429;3427.211741299515;3437.673421024999;4775.594074503671;4778.880527986794;4784.760761961923;4790.592799612003;4810.735409552473;4270.679699022586;4415.845445409395;4429.534898835608;4444.799984000728;4445.51099379068;5029;5099.87250318745;5103.387593488768;5103.626813531726;5112.718800465973;3744.6187960086763;3755.610424143057;3758.906027349311;3760.736748427611;3772.1135533149686;5201.101597916771;5349.438308977579;5355.544778693816;5363.195520671891;5382.6770393776105;3824.7322687411615;3844.0774214188395;3865.6520913117956;3868.3423817951016;3869.3615553433933;3900.9609903901164;3913.1195481016543;3914.628110329514;3920.941185882214;3926.803659816998;4279.97860010698;4399.0204408016525;4404.1411924674385;4411.205982923105;4420.497031009472;5128.307678463434;5132.332796736475;5142.251634444232;5143.17709166539;5151.5363617274625;1346.29319607207;1350.2843492948753;1356.1795113956111;1357.511295933463;1358.1647286918474;858.626497473601;880.7093659092484;926.9629214831331;942.6135284533308;957.5403806173076;4441.200583894865;4443.733375997451;4451.399061126771;4472.709273897186;4486.416765820422;5199.740012999335;5205.45342739007;5212.341705730029;5248.448912864171;5254.343207099113;4342.457192850894;4387.319965405367;4462.174497717932;4481.126180394792;4494.5505449454795;2770.3351195713285;2779.7915156363356;2786.3312804926672;2788.386554957906;2789.149309460634;4917.704937703749;4921.458639549646;4929.901401971941;4931.2247590867255;4938.8765280868265;5099.69401835891;5334.0665383557725;5346.251524786533;5407.621466497386;5473.261109750212;4990.17662085759;5006.347905191205;5012.749362531932;5017.724025178577;5038.496150384932;5304.469553044664;5308.548773354308;5309.973450132725;5312.495312945264;5314.202869569441;5001.474845141353;5217.50433708797;5251.737413129252;5253;5260.999999999847;4981.978694367718;5020.297158397754;5022.673526220784;5026.472220416804;5029.597632189343;3750.9624903751705;3762.3039737648623;3763.3978563430815;3765.964359800967;3768.491253680828;5067.366579177603;5233.345831771028;5278.84163475081;5295.205719142159;5295.391030031596;5115.386153661584;5157.381114266162;5159.045576568347;5160.870978225575;5166.535011848951;5135.255387968649;5139.948600513947;5159.561437277724;5162.432132465351;5165.431802501797;4839.370881785486;4904.509549045067;5074.797008119634;5091.541761241506;5103.417940438476;5046.772895219798;5193.714345710871;5202.791888324576;5210.635255532228;5212.218167274939;5058.041045988138;5067.974660126676;5076.36545431821;5079.5428411443145;5083.186690129562 16:07:30 INFO - PROCESS | 18483 | |5;yui.html;637.4772686397155;676.2763842688325;682.2461180395662;684.8082536889669;737.1633196322174;11784.7643047139;12418.068644851626;12553.686157846058;12567.497300107985;12568.434420451078;12507.687307817308;12842.293673847935;12849;12863;12893;627.5418944170758;642.5373730913734;754.5284197376653;783.1972228465839;794.3605397654885;790.3756032734133;799.2047912327242;800.9799755006113;801.3709238247976;802.6227672993713;850.3324889961382;850.7958090058403;851.0255757158051;852.2755657690975;852.8336974289984;653.0563335979512;815.7878951472601;823.8805373220849;831.9792005199857;844.4637655089032;609.4088733928082;611.2267981003989;612.6814056690496;612.9295131059896;612.9785457508966;12188.268703877708;12353.876461235363;12357.196782209128;12369.072319575978;12370.195937264049;12731.745365092738;13120.081594288404;13157.60527184186;13163.934180329134;13446;12146.210496317712;12186;12278.38608069593;12319.445624946899;12790.68023299425;4114.423980642712;4128.483939507561;4128.649064829493;4172.91654166918;4265.936010959838;59829.7008514959;59854;59994;60000.799984000514;60028.09957850636;9433.905660943303;9499.335046546676;9663.46850923192;9892.109710125978;10310.278280520291;18946.24215031411;19022.61954760897;19042.238310467426;19134.61730765377;19547.315843945395;6795.456363490909;6871.725130994804;6927.7228910843005;6983.930160698328;7193.388561972291;3572.160542272564;3633.927321453556;3648.3432982062955;3689.981550092286;3717.8326975286177;2693.4343787804783;2784.5962335461245;2788.63747712796;2789.246903336088;2789.860506974643;477.7635070639986;539.4228175851879;560.834553806628;569.8632328241192;572.948434640876;420.78329660225006;582.1122787748717;597.7280337446451;625.140431906129;629.2511910826103;8280.792980175544;8524.360672949553;8659.653613855502;8986.281097512183;8990.640374385082;542.2896006231849;550.8953298873201;552.240669080015;611.1688104178314;626.8808926303988;4071.7353372031316;4125.711200216017;4219.725717828332;4283.121959998193;4332.913341733148;66616;91908;92166.53916730508;92234;96166.51916740372;82535.17464825395;83135.58432207801;84452;84622.5768871164;84835.57582212049;70317.64841175762;72736;72962;76504.23495765083;77242.61378693183;7893.526388416713;7952;7953.8409231816195;7991.600419978861;8136.471129376571;41534;43108;43837.123257535306;44263.778681106385;44357.33463998107;39531.40702889401;40016.1996760069;40365;40830.59169408268;40873.182536349705;9917.355371900803;10094.990500949847;10179.541920613443;10272.178225742073;10300.175985921258;11462.828057578976;11633.825492617449;11680.94159529197;11751.294922304689;11935.224210426295;10456.947715261374;10464;10666.46667666629;11091.334519928507;11468.94265528667;9798.559064841957;10208.948955255473;10263.178945684178;10788.136949043901;10792.082672972885;10417.84373234387;10666.679999600025;10942.726431839268;11094.667159985212;11097.667069987914;8766.956165219133;8859.202671759573;8927.10728927128;9015.819683606422;9055.23030542385;9029.593668284811;9038.412503187272;9094.727158185266;9347.719568412958;9626.422414655142 16:07:30 INFO - PROCESS | 18483 | __end_tp_report 16:07:30 INFO - PROCESS | 18483 | __start_cc_report 16:07:30 INFO - PROCESS | 18483 | _x_x_mozilla_cycle_collect,1077 16:07:30 INFO - PROCESS | 18483 | __end_cc_report 16:07:30 INFO - PROCESS | 18483 | __startTimestamp1468278450782__endTimestamp 16:07:30 INFO - PROCESS | 18483 | 16:07:30 INFO - PROCESS | 18483 | ------- Summary: start ------- 16:07:30 INFO - PROCESS | 18483 | Number of tests: 6 16:07:30 INFO - PROCESS | 18483 | 16:07:30 INFO - PROCESS | 18483 | [#0] dojo.html Cycles:165 Average:4750.24 Median:4873.66 stddev:505.02 (10.4%) stddev-sans-first:477.98 16:07:30 INFO - PROCESS | 18483 | Values: 2614.9 2629.8 2651.2 2668.3 2669.3 4643.3 4710.7 4734.3 4810.1 4865.3 4780.7 4807.9 4809.0 4812.2 4824.9 4205.6 4353.8 4435.8 4488.7 4563.9 4457.5 4492.5 4517.0 4520.7 4549.0 4042.9 4273.8 4309.8 4320.7 4351.6 4352.2 4365.1 4383.5 4416.2 4444.9 4404.7 4422.1 4422.6 4464.8 4470.7 4681.7 4741.5 4800.4 4810.1 4818.3 5158.4 5207.8 5211.6 5213.7 5227.0 5222.4 5252.0 5258.4 5259.2 5259.9 4726.5 4750.8 4763.4 4770.0 4856.9 5278.4 5313.4 5314.0 5319.2 5320.5 4884.5 5039.5 5055.3 5107.6 5109.0 5063.3 5105.6 5111.8 5112.6 5136.8 5079.2 5088.9 5089.8 5090.8 5136.9 4935.1 5022.4 5059.7 5071.1 5071.9 4420.5 4427.8 4438.0 4481.3 4484.5 3816.7 3834.2 3846.2 3857.6 3882.4 4312.3 4341.2 4451.7 4486.4 4494.3 5103.6 5156.3 5161.4 5165.1 5183.5 4453.3 4455.6 4457.1 4457.2 4499.8 4509.1 4609.4 4667.0 4667.0 4707.5 4868.6 4879.9 4902.6 4923.9 4956.4 5194.9 5212.0 5216.9 5220.5 5270.7 4678.3 4739.4 4771.7 4854.2 4920.3 5014.3 5040.3 5047.5 5055.9 5085.8 5077.5 5084.6 5093.0 5100.0 5123.2 4859.4 4956.4 4997.3 5057.7 5070.2 5059.8 5070.9 5071.1 5071.3 5108.7 4962.8 4985.2 4987.4 5029.9 5034.5 4795.0 4958.8 5003.6 5015.3 5019.8 4873.7 4899.6 4906.8 4912.1 4952.9 16:07:30 INFO - PROCESS | 18483 | 16:07:30 INFO - PROCESS | 18483 | [#1] ext.html Cycles:180 Average:49122.22 Median:37545.84 stddev:86266.73 (229.8%) stddev-sans-first:86431.70 16:07:30 INFO - PROCESS | 18483 | Values: 567.6 573.7 579.3 581.5 583.6 26822.6 29784.7 29813.6 40624.4 41890.4 42098.4 42426.6 42516.4 42517.4 42573.1 7876.4 8005.9 8025.7 8026.7 8043.1 7503.7 7698.3 7709.9 7842.6 7911.3 10152.9 10443.6 10473.1 10822.8 10825.5 10308.5 10386.7 10391.5 10397.3 10398.1 7442.1 7686.6 7694.1 10196.0 10268.2 37613.8 38781.0 38886.0 41972.6 42135.8 2409.8 2460.6 2468.6 3028.7 3029.2 27454.6 30184.2 30510.2 30634.8 30734.5 3353.4 3359.5 3364.8 3393.6 3400.1 280268.0 288022.0 289317.0 289608.0 290749.0 49234.0 58580.0 60812.0 63640.4 63698.7 61174.4 61357.7 61725.0 61757.7 61798.4 14984.7 15129.6 15154.9 15169.2 15235.0 11495.3 11570.8 11580.1 11608.4 11695.1 16545.2 18885.2 19207.6 19258.1 19493.6 7224.9 7247.6 7248.6 7661.5 7686.4 703.2 782.1 868.5 869.9 872.3 25117.2 25708.9 26236.3 26364.0 26400.3 856.9 859.4 873.9 888.9 901.8 13406.6 13595.9 13793.4 13817.2 13871.3 386385.0 391354.0 392174.0 392646.0 393130.0 49527.3 49987.3 50022.5 50136.5 50197.5 1070.7 1075.6 1090.9 1135.8 1174.6 26949.2 28972.9 29622.0 30137.8 30292.7 42389.8 42762.4 42880.0 42957.1 43075.8 294675.0 296342.0 296451.6 296877.0 297765.0 32392.0 38178.6 42305.6 42358.8 42492.2 42879.6 43744.1 43985.8 44659.6 44728.6 37001.1 37115.0 37296.6 37594.2 37643.0 37524.4 37567.2 37744.4 38033.4 38093.4 37168.8 38111.0 38530.8 39464.6 40005.0 31234.0 33825.8 33851.7 33866.0 34016.0 24914.8 26150.3 26330.7 27708.3 27953.4 16:07:30 INFO - PROCESS | 18483 | 16:07:30 INFO - PROCESS | 18483 | [#2] jquery.html Cycles:180 Average:24304.16 Median:5577.60 stddev:64788.79 (1161.6%) stddev-sans-first:64945.56 16:07:30 INFO - PROCESS | 18483 | Values: 344.6 363.3 363.9 364.8 379.2 12979.6 13993.8 14743.5 17511.9 17566.0 16249.3 16398.3 16748.1 16756.9 16819.7 4868.8 5043.2 5043.6 5045.2 5048.0 3668.4 5635.2 5932.9 5943.6 6044.7 5213.5 5965.4 5982.4 6004.5 6007.0 5458.2 5554.3 5574.8 5580.4 5580.6 5303.8 5358.7 5399.6 5408.2 5488.5 20038.4 20456.1 20875.6 20965.8 20971.7 1893.8 1906.8 1911.2 2188.8 2219.5 9222.4 9258.5 9316.0 9428.6 9634.2 1705.3 1774.6 1778.9 1786.4 1818.8 49708.5 65467.3 68203.3 68725.7 70266.3 9678.6 9786.4 9897.5 10013.9 10088.5 13579.7 13661.7 13663.2 13682.8 13695.2 7097.3 7101.2 7184.4 7233.7 7299.5 6824.3 6949.7 6963.0 7088.8 7089.0 4328.4 4351.3 4400.0 4420.2 4487.6 1819.6 1834.3 1854.8 1864.7 1871.9 843.6 865.8 874.8 883.2 934.8 16669.3 17430.2 17456.0 17474.2 17794.3 870.6 881.7 884.0 914.5 924.1 9109.4 9327.0 9423.2 9504.1 9744.9 383225.0 387041.0 394844.0 395727.0 395802.0 72617.0 84474.0 86716.6 87748.0 89007.0 845.4 913.5 936.2 959.1 963.5 15850.2 15913.0 16184.8 16312.3 16598.8 29555.1 36965.6 39216.7 40407.6 40841.4 49546.8 51071.7 53788.2 55259.4 56228.0 7173.0 7353.4 7366.3 7380.7 7481.9 6030.5 7046.7 9285.9 10421.4 10617.5 9558.3 9572.0 9649.9 9703.1 9821.9 9238.7 9358.8 9362.8 9485.2 9578.4 9675.4 9682.9 9888.9 9955.9 10093.9 7001.7 7224.1 7226.0 7352.5 7488.9 7156.3 9398.2 9776.2 9807.2 10096.3 16:07:30 INFO - PROCESS | 18483 | 16:07:30 INFO - PROCESS | 18483 | [#3] mootools.html Cycles:180 Average:4905.51 Median:5742.31 stddev:2655.43 (46.2%) stddev-sans-first:2649.44 16:07:30 INFO - PROCESS | 18483 | Values: 1351.2 1415.2 1463.9 1676.2 1686.7 7040.9 7465.1 7539.5 7543.6 7545.7 6424.5 7143.0 7286.5 7288.9 7438.2 2177.2 2205.0 2207.1 2208.3 2209.8 2171.4 2184.8 2225.4 2226.6 2228.2 1896.0 2116.8 2181.4 2182.5 2189.1 2184.9 2198.0 2203.2 2224.1 2226.5 2127.5 2160.7 2162.1 2162.9 2164.4 7411.6 7426.6 7446.3 7481.3 7483.1 4335.4 4454.8 4462.7 4463.5 4479.1 2799.7 2856.3 2929.3 2941.6 2946.1 943.7 961.8 972.8 974.6 980.6 9805.7 9840.7 9844.5 9844.8 9850.5 3890.9 4056.6 4154.6 4157.8 4190.9 8490.0 8526.0 8600.6 8614.8 8625.3 4603.8 4606.4 4606.4 4607.4 4613.2 4102.1 4164.8 4235.4 4235.9 4237.6 3434.2 3438.9 3475.3 3499.5 3532.4 1003.7 1142.0 1143.6 1165.1 1166.9 790.3 808.8 827.5 871.5 883.3 4855.8 5124.8 5177.2 5209.2 5234.2 835.4 855.1 881.3 888.1 902.9 3412.9 3422.5 3452.1 3484.6 3511.0 8897.8 9206.4 9273.8 9286.9 9295.1 7745.5 8563.4 8976.0 9239.5 9252.5 6657.6 6815.3 6824.7 6837.2 6838.7 5067.1 5136.7 5263.8 5291.2 5320.0 8321.1 8325.6 8367.2 8424.1 8430.8 8158.3 8664.2 8676.3 8680.9 8697.5 6195.9 6338.8 6347.1 6351.0 6356.7 7164.5 7211.1 7225.5 7239.5 7241.5 6467.4 6551.5 6563.0 6611.7 6631.4 6014.3 6117.8 6130.5 6205.7 6209.1 5737.7 5747.0 5803.6 5805.3 5806.9 4336.4 4380.2 4404.8 4405.6 4437.6 4358.6 4389.8 4395.2 4421.3 4432.2 16:07:30 INFO - PROCESS | 18483 | 16:07:30 INFO - PROCESS | 18483 | [#4] prototype.html Cycles:180 Average:4275.57 Median:4884.52 stddev:1227.23 (25.1%) stddev-sans-first:1193.74 16:07:30 INFO - PROCESS | 18483 | Values: 294.3 294.4 302.3 302.7 303.7 4855.9 4882.6 4946.2 4947.6 4965.8 4831.0 4831.0 4880.3 4886.5 4887.7 3614.4 3726.1 3752.8 3858.3 3904.7 3841.1 3859.0 3863.7 3871.4 3895.1 3640.7 3827.6 3833.6 3838.6 3839.6 3719.8 3827.7 3832.4 3835.9 3855.3 3397.3 3414.7 3414.8 3427.2 3437.7 4775.6 4778.9 4784.8 4790.6 4810.7 4270.7 4415.8 4429.5 4444.8 4445.5 5029.0 5099.9 5103.4 5103.6 5112.7 3744.6 3755.6 3758.9 3760.7 3772.1 5201.1 5349.4 5355.5 5363.2 5382.7 3824.7 3844.1 3865.7 3868.3 3869.4 3901.0 3913.1 3914.6 3920.9 3926.8 4280.0 4399.0 4404.1 4411.2 4420.5 5128.3 5132.3 5142.3 5143.2 5151.5 1346.3 1350.3 1356.2 1357.5 1358.2 858.6 880.7 927.0 942.6 957.5 4441.2 4443.7 4451.4 4472.7 4486.4 5199.7 5205.5 5212.3 5248.4 5254.3 4342.5 4387.3 4462.2 4481.1 4494.6 2770.3 2779.8 2786.3 2788.4 2789.1 4917.7 4921.5 4929.9 4931.2 4938.9 5099.7 5334.1 5346.3 5407.6 5473.3 4990.2 5006.3 5012.7 5017.7 5038.5 5304.5 5308.5 5310.0 5312.5 5314.2 5001.5 5217.5 5251.7 5253.0 5261.0 4982.0 5020.3 5022.7 5026.5 5029.6 3751.0 3762.3 3763.4 3766.0 3768.5 5067.4 5233.3 5278.8 5295.2 5295.4 5115.4 5157.4 5159.0 5160.9 5166.5 5135.3 5139.9 5159.6 5162.4 5165.4 4839.4 4904.5 5074.8 5091.5 5103.4 5046.8 5193.7 5202.8 5210.6 5212.2 5058.0 5068.0 5076.4 5079.5 5083.2 16:07:30 INFO - PROCESS | 18483 | 16:07:30 INFO - PROCESS | 18483 | [#5] yui.html Cycles:180 Average:16606.87 Median:565.35 stddev:23501.67 (4157.0%) stddev-sans-first:23537.00 16:07:30 INFO - PROCESS | 18483 | Values: 637.5 676.3 682.2 684.8 737.2 11784.8 12418.1 12553.7 12567.5 12568.4 12507.7 12842.3 12849.0 12863.0 12893.0 627.5 642.5 754.5 783.2 794.4 790.4 799.2 801.0 801.4 802.6 850.3 850.8 851.0 852.3 852.8 653.1 815.8 823.9 832.0 844.5 609.4 611.2 612.7 612.9 613.0 12188.3 12353.9 12357.2 12369.1 12370.2 12731.7 13120.1 13157.6 13163.9 13446.0 12146.2 12186.0 12278.4 12319.4 12790.7 4114.4 4128.5 4128.6 4172.9 4265.9 59829.7 59854.0 59994.0 60000.8 60028.1 9433.9 9499.3 9663.5 9892.1 10310.3 18946.2 19022.6 19042.2 19134.6 19547.3 6795.5 6871.7 6927.7 6983.9 7193.4 3572.2 3633.9 3648.3 3690.0 3717.8 2693.4 2784.6 2788.6 2789.2 2789.9 477.8 539.4 560.8 569.9 572.9 420.8 582.1 597.7 625.1 629.3 8280.8 8524.4 8659.7 8986.3 8990.6 542.3 550.9 552.2 611.2 626.9 4071.7 4125.7 4219.7 4283.1 4332.9 66616.0 91908.0 92166.5 92234.0 96166.5 82535.2 83135.6 84452.0 84622.6 84835.6 70317.6 72736.0 72962.0 76504.2 77242.6 7893.5 7952.0 7953.8 7991.6 8136.5 41534.0 43108.0 43837.1 44263.8 44357.3 39531.4 40016.2 40365.0 40830.6 40873.2 9917.4 10095.0 10179.5 10272.2 10300.2 11462.8 11633.8 11680.9 11751.3 11935.2 10456.9 10464.0 10666.5 11091.3 11468.9 9798.6 10208.9 10263.2 10788.1 10792.1 10417.8 10666.7 10942.7 11094.7 11097.7 8767.0 8859.2 8927.1 9015.8 9055.2 9029.6 9038.4 9094.7 9347.7 9626.4 16:07:30 INFO - PROCESS | 18483 | -------- Summary: end -------- 16:07:30 INFO - PROCESS | 18483 | 16:07:31 INFO - TEST-INFO | 18483: exit 0 16:07:31 INFO - TEST-OK | dromaeo_css | took 1119891ms 16:07:31 INFO - TEST-START | kraken 16:07:31 INFO - operating with platform_type : linux_ 16:07:31 INFO - Initialising browser for kraken test... 16:07:31 INFO - TEST-INFO | started process 18678 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIERkXR/profile http://localhost:59732/getInfo.html) 16:07:35 INFO - PROCESS | 18678 | __metrics Screen width/height:1600/1200 16:07:35 INFO - PROCESS | 18678 | colorDepth:24 16:07:35 INFO - PROCESS | 18678 | Browser inner width/height: 1024/697 16:07:35 INFO - PROCESS | 18678 | __metrics 16:07:36 INFO - PROCESS | 18678 | 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:07:36 INFO - PROCESS | 18678 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:07:37 INFO - PROCESS | 18678 | console.error: PushService: 16:07:37 INFO - PROCESS | 18678 | stateChangeProcessEnqueue: Error transitioning state 16:07:37 INFO - PROCESS | 18678 | UnknownError 16:07:37 INFO - TEST-INFO | 18678: exit 0 16:07:37 INFO - Browser initialized. 16:07:37 INFO - Running cycle 1/1 for kraken test... 16:07:37 INFO - TEST-INFO | started process 18759 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIERkXR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:07:49 INFO - PROCESS | 18759 | RSS: Main: 159047680 16:07:49 INFO - PROCESS | 18759 | 16:07:52 INFO - PROCESS | 18759 | Cycle 1(1): loaded http://localhost:59732/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59732/tests/kraken/driver.html?testName=audio-beat-detection) 16:07:53 INFO - PROCESS | 18759 | RSS: Main: 217042944 16:07:53 INFO - PROCESS | 18759 | 16:07:55 INFO - PROCESS | 18759 | Cycle 1(1): loaded http://localhost:59732/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59732/tests/kraken/driver.html?testName=audio-dft) 16:07:56 INFO - PROCESS | 18759 | RSS: Main: 203939840 16:07:56 INFO - PROCESS | 18759 | 16:07:59 INFO - PROCESS | 18759 | Cycle 1(1): loaded http://localhost:59732/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59732/tests/kraken/driver.html?testName=audio-fft) 16:08:00 INFO - PROCESS | 18759 | RSS: Main: 271368192 16:08:00 INFO - PROCESS | 18759 | 16:08:02 INFO - PROCESS | 18759 | Cycle 1(1): loaded http://localhost:59732/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59732/tests/kraken/driver.html?testName=audio-oscillator) 16:08:03 INFO - PROCESS | 18759 | RSS: Main: 181760000 16:08:03 INFO - PROCESS | 18759 | 16:08:05 INFO - PROCESS | 18759 | Cycle 1(1): loaded http://localhost:59732/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59732/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:08:06 INFO - PROCESS | 18759 | RSS: Main: 185499648 16:08:06 INFO - PROCESS | 18759 | 16:08:09 INFO - PROCESS | 18759 | Cycle 1(1): loaded http://localhost:59732/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59732/tests/kraken/driver.html?testName=imaging-darkroom) 16:08:09 INFO - PROCESS | 18759 | RSS: Main: 221814784 16:08:09 INFO - PROCESS | 18759 | 16:08:13 INFO - PROCESS | 18759 | Cycle 1(1): loaded http://localhost:59732/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59732/tests/kraken/driver.html?testName=imaging-desaturate) 16:08:13 INFO - PROCESS | 18759 | RSS: Main: 222277632 16:08:13 INFO - PROCESS | 18759 | 16:08:16 INFO - PROCESS | 18759 | Cycle 1(1): loaded http://localhost:59732/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59732/tests/kraken/driver.html?testName=json-parse-financial) 16:08:17 INFO - PROCESS | 18759 | RSS: Main: 221933568 16:08:17 INFO - PROCESS | 18759 | 16:08:19 INFO - PROCESS | 18759 | Cycle 1(1): loaded http://localhost:59732/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59732/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:08:19 INFO - PROCESS | 18759 | RSS: Main: 208105472 16:08:19 INFO - PROCESS | 18759 | 16:08:21 INFO - PROCESS | 18759 | Cycle 1(1): loaded http://localhost:59732/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59732/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:08:22 INFO - PROCESS | 18759 | RSS: Main: 211550208 16:08:22 INFO - PROCESS | 18759 | 16:08:24 INFO - PROCESS | 18759 | Cycle 1(1): loaded http://localhost:59732/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59732/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:08:25 INFO - PROCESS | 18759 | RSS: Main: 208220160 16:08:25 INFO - PROCESS | 18759 | 16:08:27 INFO - PROCESS | 18759 | Cycle 1(1): loaded http://localhost:59732/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59732/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:08:28 INFO - PROCESS | 18759 | RSS: Main: 222629888 16:08:28 INFO - PROCESS | 18759 | 16:08:31 INFO - PROCESS | 18759 | Cycle 1(1): loaded http://localhost:59732/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59732/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:08:32 INFO - PROCESS | 18759 | RSS: Main: 223186944 16:08:32 INFO - PROCESS | 18759 | 16:08:33 INFO - PROCESS | 18759 | Cycle 1(1): loaded http://localhost:59732/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59732/tests/kraken/driver.html?testName=ai-astar) 16:08:34 INFO - PROCESS | 18759 | RSS: Main: 265293824 16:08:34 INFO - PROCESS | 18759 | 16:08:34 INFO - PROCESS | 18759 | __start_tp_report 16:08:34 INFO - PROCESS | 18759 | _x_x_mozilla_page_load 16:08:34 INFO - PROCESS | 18759 | _x_x_mozilla_page_load_details 16:08:34 INFO - PROCESS | 18759 | |i|pagename|runs| 16:08:34 INFO - PROCESS | 18759 | |0;ai-astar;104;114;113;116;113;114;112;113;115;114 16:08:34 INFO - PROCESS | 18759 | |1;audio-beat-detection;150;122;123;182;125;124;144;127;160;127 16:08:34 INFO - PROCESS | 18759 | |2;audio-dft;160;163;160;159;161;161;161;162;161;161 16:08:34 INFO - PROCESS | 18759 | |3;audio-fft;76;75;76;125;78;76;77;76;103;75 16:08:34 INFO - PROCESS | 18759 | |4;audio-oscillator;84;87;113;86;86;84;125;85;85;123 16:08:34 INFO - PROCESS | 18759 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 16:08:34 INFO - PROCESS | 18759 | |6;imaging-darkroom;147;146;147;147;146;146;147;147;147;146 16:08:34 INFO - PROCESS | 18759 | |7;imaging-desaturate;95;95;95;95;95;95;95;96;96;94 16:08:34 INFO - PROCESS | 18759 | |8;json-parse-financial;63;62;64;63;63;65;64;63;64;63 16:08:34 INFO - PROCESS | 18759 | |9;json-stringify-tinderbox;66;66;66;66;67;66;76;65;65;64 16:08:34 INFO - PROCESS | 18759 | |10;stanford-crypto-aes;78;80;79;86;79;79;79;79;78;79 16:08:34 INFO - PROCESS | 18759 | |11;stanford-crypto-ccm;132;134;137;140;136;131;132;132;212;131 16:08:34 INFO - PROCESS | 18759 | |12;stanford-crypto-pbkdf2;175;170;166;164;163;167;166;165;167;169 16:08:34 INFO - PROCESS | 18759 | |13;stanford-crypto-sha256-iterative;73;71;67;70;66;65;70;67;66;73 16:08:34 INFO - PROCESS | 18759 | __end_tp_report 16:08:34 INFO - PROCESS | 18759 | __start_cc_report 16:08:34 INFO - PROCESS | 18759 | _x_x_mozilla_cycle_collect,1895 16:08:34 INFO - PROCESS | 18759 | __end_cc_report 16:08:34 INFO - PROCESS | 18759 | __startTimestamp1468278514096__endTimestamp 16:08:34 INFO - PROCESS | 18759 | 16:08:34 INFO - PROCESS | 18759 | ------- Summary: start ------- 16:08:34 INFO - PROCESS | 18759 | Number of tests: 14 16:08:34 INFO - PROCESS | 18759 | 16:08:34 INFO - PROCESS | 18759 | [#0] ai-astar Cycles:10 Average:112.80 Median:114.00 stddev:3.29 (2.9%) stddev-sans-first:1.20 16:08:34 INFO - PROCESS | 18759 | Values: 104.0 114.0 113.0 116.0 113.0 114.0 112.0 113.0 115.0 114.0 16:08:34 INFO - PROCESS | 18759 | 16:08:34 INFO - PROCESS | 18759 | [#1] audio-beat-detection Cycles:10 Average:138.40 Median:135.50 stddev:20.24 (14.9%) stddev-sans-first:21.03 16:08:34 INFO - PROCESS | 18759 | Values: 150.0 122.0 123.0 182.0 125.0 124.0 144.0 127.0 160.0 127.0 16:08:34 INFO - PROCESS | 18759 | 16:08:34 INFO - PROCESS | 18759 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:1.10 (0.7%) stddev-sans-first:1.12 16:08:34 INFO - PROCESS | 18759 | Values: 160.0 163.0 160.0 159.0 161.0 161.0 161.0 162.0 161.0 161.0 16:08:34 INFO - PROCESS | 18759 | 16:08:34 INFO - PROCESS | 18759 | [#3] audio-fft Cycles:10 Average:83.70 Median:76.00 stddev:16.81 (22.1%) stddev-sans-first:17.60 16:08:34 INFO - PROCESS | 18759 | Values: 76.0 75.0 76.0 125.0 78.0 76.0 77.0 76.0 103.0 75.0 16:08:34 INFO - PROCESS | 18759 | 16:08:34 INFO - PROCESS | 18759 | [#4] audio-oscillator Cycles:10 Average:95.80 Median:85.00 stddev:17.22 (20.3%) stddev-sans-first:17.73 16:08:34 INFO - PROCESS | 18759 | Values: 84.0 87.0 113.0 86.0 86.0 84.0 125.0 85.0 85.0 123.0 16:08:34 INFO - PROCESS | 18759 | 16:08:34 INFO - PROCESS | 18759 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 16:08:34 INFO - PROCESS | 18759 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 16:08:34 INFO - PROCESS | 18759 | 16:08:34 INFO - PROCESS | 18759 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 16:08:34 INFO - PROCESS | 18759 | Values: 147.0 146.0 147.0 147.0 146.0 146.0 147.0 147.0 147.0 146.0 16:08:34 INFO - PROCESS | 18759 | 16:08:34 INFO - PROCESS | 18759 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 16:08:34 INFO - PROCESS | 18759 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 96.0 94.0 16:08:34 INFO - PROCESS | 18759 | 16:08:34 INFO - PROCESS | 18759 | [#8] json-parse-financial Cycles:10 Average:63.40 Median:63.50 stddev:0.84 (1.3%) stddev-sans-first:0.88 16:08:34 INFO - PROCESS | 18759 | Values: 63.0 62.0 64.0 63.0 63.0 65.0 64.0 63.0 64.0 63.0 16:08:34 INFO - PROCESS | 18759 | 16:08:34 INFO - PROCESS | 18759 | [#9] json-stringify-tinderbox Cycles:10 Average:66.70 Median:66.00 stddev:3.37 (5.1%) stddev-sans-first:3.56 16:08:34 INFO - PROCESS | 18759 | Values: 66.0 66.0 66.0 66.0 67.0 66.0 76.0 65.0 65.0 64.0 16:08:34 INFO - PROCESS | 18759 | 16:08:34 INFO - PROCESS | 18759 | [#10] stanford-crypto-aes Cycles:10 Average:79.60 Median:79.00 stddev:2.32 (2.9%) stddev-sans-first:2.39 16:08:34 INFO - PROCESS | 18759 | Values: 78.0 80.0 79.0 86.0 79.0 79.0 79.0 79.0 78.0 79.0 16:08:34 INFO - PROCESS | 18759 | 16:08:34 INFO - PROCESS | 18759 | [#11] stanford-crypto-ccm Cycles:10 Average:141.70 Median:135.00 stddev:24.88 (18.4%) stddev-sans-first:26.14 16:08:34 INFO - PROCESS | 18759 | Values: 132.0 134.0 137.0 140.0 136.0 131.0 132.0 132.0 212.0 131.0 16:08:34 INFO - PROCESS | 18759 | 16:08:34 INFO - PROCESS | 18759 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.20 Median:167.00 stddev:3.46 (2.1%) stddev-sans-first:2.24 16:08:34 INFO - PROCESS | 18759 | Values: 175.0 170.0 166.0 164.0 163.0 167.0 166.0 165.0 167.0 169.0 16:08:34 INFO - PROCESS | 18759 | 16:08:34 INFO - PROCESS | 18759 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:70.00 stddev:2.97 (4.2%) stddev-sans-first:2.74 16:08:34 INFO - PROCESS | 18759 | Values: 73.0 71.0 67.0 70.0 66.0 65.0 70.0 67.0 66.0 73.0 16:08:34 INFO - PROCESS | 18759 | -------- Summary: end -------- 16:08:34 INFO - PROCESS | 18759 | 16:08:35 INFO - TEST-INFO | 18759: exit 0 16:08:35 INFO - TEST-OK | kraken | took 63675ms 16:08:35 INFO - SUITE-END | took 1183s 16:08:35 INFO - Completed test suite (00:19:43) 16:08:35 INFO - javascript benchmark 16:08:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2614.895404183833, 2629.7633213010827, 2651.217890722237, 2668.3195785074804, 2669.2926374510757, 4643.349931009661, 4710.6938049026785, 4734.274558117812, 4810.134175848341, 4865.270209468577, 4780.737059461728, 4807.903841923159, 4808.966072294456, 4812.205986012304, 4824.855254342367, 4205.621494065534, 4353.825846966118, 4435.775537386323, 4488.685791994561, 4563.885902852422, 4457.465104187502, 4492.528284530126, 4516.954830451703, 4520.68355215135, 4549.021960278539, 4042.858499952517, 4273.786310684453, 4309.784510774449, 4320.740755554645, 4351.586599273064, 4352.151330490556, 4365.083332500179, 4383.495897971742, 4416.227160246944, 4444.911101777979, 4404.69167158299, 4422.071365013351, 4422.5577442255835, 4464.776761161929, 4470.731756094645, 4681.695689780154, 4741.525847415265, 4800.399950006249, 4810.06203790261, 4818.277258411266, 5158.4067832199025, 5207.817726379596, 5211.609129315279, 5213.713245771481, 5227.0, 5222.4255331913455, 5252.0, 5258.3689957205, 5259.237410575445, 5259.947400525984, 4726.503717109688, 4750.8337208197545, 4763.428388593322, 4770.0221454602415, 4856.902861942742, 5278.445763194886, 5313.442088580643, 5313.973430132902, 5319.175527793198, 5320.467953204726, 4884.535969082932, 5039.546440820343, 5055.292259083732, 5107.642465027412, 5108.9744551277745, 5063.291139240509, 5105.642605017613, 5111.846644600668, 5112.565431938253, 5136.8202112925865, 5079.238114282887, 5088.92366614501, 5089.847304580869, 5090.821821236239, 5136.871578210575, 4935.087008903364, 5022.397312322471, 5059.696418214919, 5071.0872043032605, 5071.923921141186, 4420.491643461043, 4427.8228870844805, 4437.955620443819, 4481.305397663367, 4484.484284307281, 3816.7328287020196, 3834.1564855731694, 3846.1730727893637, 3857.556381016163, 3882.4176373544196, 4312.288472402081, 4341.175176716414, 4451.732896026184, 4486.439195100613, 4494.348319493655, 5103.617228707862, 5156.278121063054, 5161.406438259573, 5165.070287348313, 5183.481651834786, 4453.332000199931, 4455.598996090367, 4457.108578284357, 4457.153140903218, 4499.77501124949, 4509.143262780061, 4609.354690343354, 4667.019925815617, 4667.043256132485, 4707.458642256116, 4868.586170175575, 4879.853604391874, 4902.60779137661, 4923.901521969612, 4956.405231372259, 5194.8961020780125, 5212.035773381785, 5216.921746173734, 5220.477952204901, 5270.736463176902, 4678.345031695633, 4739.4075740532435, 4771.66598338113, 4854.2233242681, 4920.335754673217, 5014.34813474246, 5040.269160971565, 5047.520485553867, 5055.87360315995, 5085.821996230115, 5077.543021128116, 5084.618653600921, 5093.032323858455, 5099.974500127476, 5123.205903085028, 4859.392575928009, 4956.3804524434445, 4997.300377947017, 5057.74711264428, 5070.239464080418, 5059.848204553869, 5070.949290507047, 5071.061853557104, 5071.315372424676, 5108.693478391308, 4962.801487940442, 4985.152524070989, 4987.401511818605, 5029.9245511318095, 5034.546890779848, 4795.040991801584, 4958.752062396938, 5003.574696150868, 5015.272785446163, 5019.799208031784, 4873.658843880894, 4899.608031357411, 4906.754662266943, 4912.066707325596, 4952.8761780955765], "value": 4717.445759807395, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.6395488864571, 573.7475510775256, 579.2787978966188, 581.4505292498591, 583.643977173924, 26822.5976610351, 29784.702152978465, 29813.552796708067, 40624.39063414051, 41890.37164442528, 42098.36852447216, 42426.57573424265, 42516.36225456621, 42517.362239566355, 42573.14853702924, 7876.369890408782, 8005.919940800605, 8025.6789728410795, 8026.719064832732, 8043.075046369655, 7503.662335194929, 7698.307152356287, 7709.922900771005, 7842.607869606497, 7911.327537159348, 10152.949235253813, 10443.582256709722, 10473.057424831764, 10822.837657435144, 10825.458727063655, 10308.536115874766, 10386.740331491697, 10391.48042597867, 10397.272190946636, 10398.116160126398, 7442.144153422371, 7686.615669216517, 7694.115176754689, 10196.0, 10268.178545716324, 37613.81193094044, 38781.03047423837, 38886.0, 41972.58027419717, 42135.789321053504, 2409.771071748181, 2460.6309053641917, 2468.5926822074334, 3028.712272334125, 3029.1972627253795, 27454.5881811773, 30184.24539386511, 30510.237244068852, 30634.84682576595, 30734.538981915288, 3353.4131526982924, 3359.5128706337446, 3364.814935178564, 3393.6436674149354, 3400.1159698478327, 280268.0, 288021.9999999979, 289317.0, 289608.0, 290749.0, 49234.0, 58580.0, 60812.0, 63640.36359636437, 63698.68150659217, 61174.38825611776, 61357.69321153365, 61725.0, 61757.69121154455, 61798.38201617926, 14984.70030599382, 15129.621759456102, 15154.924225378803, 15169.24153792306, 15235.0, 11495.252808567417, 11570.76858462826, 11580.073594112619, 11608.361540115206, 11695.070313398364, 16545.172741362883, 18885.15016824246, 19207.61584768297, 19258.133383997752, 19493.610127797365, 7224.906440959111, 7247.565146091146, 7248.60132692707, 7661.502002369828, 7686.423518236154, 703.2334755116947, 782.0537150048391, 868.5440143924491, 869.9043105258417, 872.289084396215, 25117.160235317726, 25708.871455642602, 26236.344091397485, 26364.0, 26400.339991499983, 856.8629019356997, 859.3984211052289, 873.9038705742363, 888.9377743558018, 901.8151278987792, 13406.597802065953, 13595.932020339835, 13793.448262069405, 13817.240051797247, 13871.306434678225, 386385.0, 391354.0, 392174.0, 392646.0, 393130.0, 49527.25709114366, 49987.25019124716, 50022.49977500179, 50136.498635013915, 50197.49802502001, 1070.6573896353093, 1075.6074032977906, 1090.9399983000853, 1135.761490087091, 1174.6417342710556, 26949.191524254304, 28972.855135724185, 29622.0, 30137.849310753307, 30292.697073028987, 42389.78805106078, 42762.35856462093, 42880.0, 42957.14085718331, 43075.784621076695, 294675.0, 296342.0, 296451.6241931522, 296877.0, 297765.0, 32392.0, 38178.618213817506, 42305.5769442314, 42358.78820605877, 42492.15015699607, 42879.57120428756, 43744.12511749811, 43985.78007109944, 44659.553404465536, 44728.55271447244, 37001.07497312481, 37115.0, 37296.62703372932, 37594.24811503809, 37643.0, 37524.437133443564, 37567.248655027295, 37744.433833493065, 38033.42949855699, 38093.4285985716, 37168.814155929045, 38111.0, 38530.80734596309, 39464.60535394724, 40005.0, 31234.0, 33825.830870845486, 33851.66148338485, 33866.0, 34016.0, 24914.750852491245, 26150.34624134336, 26330.73669263283, 27708.30729231785, 27953.440931180856], "value": 18201.09450298294, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.63352806123714, 363.30608537693, 363.8762820640983, 364.79389145132996, 379.1818231579576, 12979.610611681654, 13993.790093148611, 14743.483978060756, 17511.912440437813, 17566.0, 16249.268782904768, 16398.26207820648, 16748.078855662934, 16756.916215418936, 16819.747703784422, 4868.805247790093, 5043.218301163325, 5043.596512279028, 5045.21799121135, 5048.040872234282, 3668.3580373434543, 5635.239242702224, 5932.940670593303, 5943.613665111776, 6044.7279872405625, 5213.452587478317, 5965.433283838051, 5982.401759824026, 6004.489618382443, 6006.969965150168, 5458.153986132156, 5554.2779438672715, 5574.804881829116, 5580.386157522669, 5580.553555715554, 5303.814366497193, 5358.705271210082, 5399.62202645815, 5408.188771684239, 5488.4785945335125, 20038.398848034583, 20456.079476423598, 20875.5824883503, 20965.790342096538, 20971.685424718642, 1893.848492120627, 1906.761654793151, 1911.2068491575978, 2188.8248940084754, 2219.4673278413225, 9222.40054396462, 9258.490783006931, 9316.02181770918, 9428.575714092882, 9634.229261659051, 1705.309349713368, 1774.6007148391639, 1778.8932664040199, 1786.4457921608155, 1818.818118188184, 49708.50291497075, 65467.3453265466, 68203.31796682019, 68725.65637171832, 70266.297337027, 9678.56446459911, 9786.41281523111, 9897.455639939872, 10013.949930250303, 10088.546015429323, 13579.728405431835, 13661.658458538615, 13663.248521331423, 13682.794758078637, 13695.178289302674, 7097.325754053357, 7101.183363913216, 7184.389326907167, 7233.674484648203, 7299.489035767445, 6824.283450237753, 6949.652517374111, 6962.965185174042, 7088.7518936838, 7089.0, 4328.350747387917, 4351.325544540601, 4399.978000110043, 4420.204363214652, 4487.618552423015, 1819.6087841114224, 1834.3488061738158, 1854.7588813454165, 1864.7296142059326, 1871.8970456625016, 843.5908584336592, 865.7662431143556, 874.8381549413378, 883.2139395937621, 934.7709811096325, 16669.3332266708, 17430.215640296217, 17456.0, 17474.213660385314, 17794.288228470974, 870.5821205821242, 881.6914080072052, 883.960221790021, 914.4650379527918, 924.1082355526949, 9109.407888487227, 9326.95336523313, 9423.19902808269, 9504.144626983467, 9744.853827192597, 383225.0, 387041.0, 394844.0, 395727.0, 395802.0, 72617.0, 84474.0, 86716.56641716752, 87748.0, 89007.0, 845.4335595151264, 913.48388160689, 936.194872409727, 959.0888655777039, 963.4604621412032, 15850.207489625704, 15913.0, 16184.757228641345, 16312.265948032129, 16598.75101873497, 29555.113346599635, 36965.63034369622, 39216.66658334074, 40407.59592404156, 40841.38737918993, 49546.752266238436, 51071.74464127656, 53788.193177101595, 55259.44740552543, 56228.0, 7172.964135179291, 7353.411727061715, 7366.263373662805, 7380.741674041383, 7481.925180748123, 6030.4572588467245, 7046.682899269443, 9285.885693716797, 10421.426821524889, 10617.522211500656, 9558.28312876551, 9572.0, 9649.9035009649, 9703.107893960892, 9821.901780982385, 9238.676646317346, 9358.812823743623, 9362.765930851783, 9485.193758530602, 9578.377405468622, 9675.419474831533, 9682.886468056264, 9888.851667224853, 9955.850662240216, 10093.949530252596, 7001.719931202695, 7224.13310402755, 7225.963870180825, 7352.5220860643885, 7488.850222995618, 7156.320149585781, 9398.154166125081, 9776.169025632616, 9807.215422766305, 10096.29325947206], "value": 8109.525901415834, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1351.2095424176855, 1415.1933397963162, 1463.9414423423063, 1676.1954261954254, 1686.6542358816444, 7040.859182816341, 7465.104187497494, 7539.472236943416, 7543.622818859056, 7545.660445279955, 6424.486041116711, 7142.96428517858, 7286.52637578557, 7288.890666640004, 7438.218987006368, 2177.1617927098023, 2205.018766648842, 2207.0840601150503, 2208.3043841190056, 2209.823214142865, 2171.381156370435, 2184.759676435591, 2225.410266279429, 2226.554689062186, 2228.1644383356243, 1895.962080758384, 2116.841236907238, 2181.3564998325533, 2182.454386403399, 2189.069645400706, 2184.8907554622365, 2197.9890100549555, 2203.1627981367137, 2224.0547767199037, 2226.5101677630896, 2127.489402543394, 2160.686700428445, 2162.1135334512774, 2162.91348346066, 2164.350694791556, 7411.592362420065, 7426.554406735613, 7446.255374462565, 7481.326680598718, 7483.1020277566495, 4335.414719012924, 4454.77726113693, 4462.687611867171, 4463.509014008457, 4479.104179164147, 2799.720027997184, 2856.3002064494126, 2929.2530404746867, 2941.57347184657, 2946.0719873240073, 943.688582767685, 961.7787908780949, 972.7665360313545, 974.605284859633, 980.5636491761169, 9805.705828825146, 9840.65557705477, 9844.458554779412, 9844.753881153028, 9850.458224797634, 3890.8638197663513, 4056.5943405659787, 4154.605312495308, 4157.812898419578, 4190.895227619273, 8489.95755021221, 8526.0, 8600.5699715014, 8614.827703445895, 8625.309975201968, 4603.815847366135, 4606.424196975378, 4606.447226332794, 4607.424071991001, 4613.192691279013, 4102.138550904284, 4164.7917604119675, 4235.385869048971, 4235.851745188904, 4237.5762423758, 3434.1929646533044, 3438.862445502202, 3475.3223121491064, 3499.545059142295, 3532.3994920863515, 1003.6838395905412, 1141.9543218271342, 1143.5654451308617, 1165.1377980294521, 1166.8949794518535, 790.2650535002502, 808.7533302342724, 827.4952279109739, 871.5293741379711, 883.262475832687, 4855.830045948375, 5124.820631277962, 5177.223416487557, 5209.244659524424, 5234.241035049897, 835.4360806455618, 855.1363123245443, 881.2729498163912, 888.1030159538783, 902.873597696323, 3412.931741365159, 3422.486627005919, 3452.1197094740683, 3484.564429446319, 3511.0, 8897.777555561033, 9206.447613143233, 9273.768155796024, 9286.860697089549, 9295.11696388842, 7745.496542724705, 8563.400561960727, 8976.0, 9239.491827949527, 9252.49111298885, 6657.567258128303, 6815.250322464426, 6824.727010919508, 6837.213720422115, 6838.658067096625, 5067.113255180402, 5136.717480538607, 5263.815766448156, 5291.153415453509, 5320.0, 8321.126281740571, 8325.625346859284, 8367.163283671583, 8424.073351931405, 8430.831383372175, 8158.265756081981, 8664.220220179963, 8676.349273804364, 8680.869786953075, 8697.52163630981, 6195.907061393992, 6338.778142765165, 6347.079673447232, 6351.047342898602, 6356.745730170742, 7164.462665300019, 7211.062561867134, 7225.530340527849, 7239.493235473677, 7241.5293005954445, 6467.417932386108, 6551.50863685216, 6562.967185164043, 6611.735530578915, 6631.403173714389, 6014.27828660546, 6117.785877494266, 6130.50955923534, 6205.689715514297, 6209.130721699056, 5737.655740655574, 5746.9712651436475, 5803.622764520293, 5805.3033635962265, 5806.883862322646, 4336.436263285753, 4380.211561918885, 4404.801783919667, 4405.622848526338, 4437.5784300491405, 4358.607725304738, 4389.824407023811, 4395.230834603995, 4421.336799480104, 4432.202203603253], "value": 4009.520477003671, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.27020987949885, 294.41705423261936, 302.30319114441215, 302.65799646399563, 303.743336880336, 4855.927161092582, 4882.5596449047525, 4946.18387965986, 4947.579455746266, 4965.776540055697, 4830.951690483094, 4831.0, 4880.316755654211, 4886.48691887352, 4887.7311747853855, 3614.3855544557355, 3726.142987112966, 3752.774833509998, 3858.266929283441, 3904.726669133162, 3841.1165431950667, 3858.977370996688, 3863.6624841970483, 3871.399933010388, 3895.1235971906376, 3640.7451478396524, 3827.5598306194865, 3833.5974722654137, 3838.6161383861668, 3839.6352346527037, 3719.8140092995377, 3827.674647654953, 3832.3868181090893, 3835.9232815343817, 3855.3253180693405, 3397.3205358928067, 3414.6756058174433, 3414.778039427429, 3427.211741299515, 3437.673421024999, 4775.594074503671, 4778.880527986794, 4784.760761961923, 4790.592799612003, 4810.735409552473, 4270.679699022586, 4415.845445409395, 4429.534898835608, 4444.799984000728, 4445.51099379068, 5029.0, 5099.87250318745, 5103.387593488768, 5103.626813531726, 5112.718800465973, 3744.6187960086763, 3755.610424143057, 3758.906027349311, 3760.736748427611, 3772.1135533149686, 5201.101597916771, 5349.438308977579, 5355.544778693816, 5363.195520671891, 5382.6770393776105, 3824.7322687411615, 3844.0774214188395, 3865.6520913117956, 3868.3423817951016, 3869.3615553433933, 3900.9609903901164, 3913.1195481016543, 3914.628110329514, 3920.941185882214, 3926.803659816998, 4279.97860010698, 4399.0204408016525, 4404.1411924674385, 4411.205982923105, 4420.497031009472, 5128.307678463434, 5132.332796736475, 5142.251634444232, 5143.17709166539, 5151.5363617274625, 1346.29319607207, 1350.2843492948753, 1356.1795113956111, 1357.511295933463, 1358.1647286918474, 858.626497473601, 880.7093659092484, 926.9629214831331, 942.6135284533308, 957.5403806173076, 4441.200583894865, 4443.733375997451, 4451.399061126771, 4472.709273897186, 4486.416765820422, 5199.740012999335, 5205.45342739007, 5212.341705730029, 5248.448912864171, 5254.343207099113, 4342.457192850894, 4387.319965405367, 4462.174497717932, 4481.126180394792, 4494.5505449454795, 2770.3351195713285, 2779.7915156363356, 2786.3312804926672, 2788.386554957906, 2789.149309460634, 4917.704937703749, 4921.458639549646, 4929.901401971941, 4931.2247590867255, 4938.8765280868265, 5099.69401835891, 5334.0665383557725, 5346.251524786533, 5407.621466497386, 5473.261109750212, 4990.17662085759, 5006.347905191205, 5012.749362531932, 5017.724025178577, 5038.496150384932, 5304.469553044664, 5308.548773354308, 5309.973450132725, 5312.495312945264, 5314.202869569441, 5001.474845141353, 5217.50433708797, 5251.737413129252, 5253.0, 5260.999999999847, 4981.978694367718, 5020.297158397754, 5022.673526220784, 5026.472220416804, 5029.597632189343, 3750.9624903751705, 3762.3039737648623, 3763.3978563430815, 3765.964359800967, 3768.491253680828, 5067.366579177603, 5233.345831771028, 5278.84163475081, 5295.205719142159, 5295.391030031596, 5115.386153661584, 5157.381114266162, 5159.045576568347, 5160.870978225575, 5166.535011848951, 5135.255387968649, 5139.948600513947, 5159.561437277724, 5162.432132465351, 5165.431802501797, 4839.370881785486, 4904.509549045067, 5074.797008119634, 5091.541761241506, 5103.417940438476, 5046.772895219798, 5193.714345710871, 5202.791888324576, 5210.635255532228, 5212.218167274939, 5058.041045988138, 5067.974660126676, 5076.36545431821, 5079.5428411443145, 5083.186690129562], "value": 3887.1095374391484, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [637.4772686397155, 676.2763842688325, 682.2461180395662, 684.8082536889669, 737.1633196322174, 11784.7643047139, 12418.068644851626, 12553.686157846058, 12567.497300107985, 12568.434420451078, 12507.687307817308, 12842.293673847935, 12849.0, 12863.0, 12893.0, 627.5418944170758, 642.5373730913734, 754.5284197376653, 783.1972228465839, 794.3605397654885, 790.3756032734133, 799.2047912327242, 800.9799755006113, 801.3709238247976, 802.6227672993713, 850.3324889961382, 850.7958090058403, 851.0255757158051, 852.2755657690975, 852.8336974289984, 653.0563335979512, 815.7878951472601, 823.8805373220849, 831.9792005199857, 844.4637655089032, 609.4088733928082, 611.2267981003989, 612.6814056690496, 612.9295131059896, 612.9785457508966, 12188.268703877708, 12353.876461235363, 12357.196782209128, 12369.072319575978, 12370.195937264049, 12731.745365092738, 13120.081594288404, 13157.60527184186, 13163.934180329134, 13446.0, 12146.210496317712, 12186.0, 12278.38608069593, 12319.445624946899, 12790.68023299425, 4114.423980642712, 4128.483939507561, 4128.649064829493, 4172.91654166918, 4265.936010959838, 59829.7008514959, 59854.0, 59994.0, 60000.799984000514, 60028.09957850636, 9433.905660943303, 9499.335046546676, 9663.46850923192, 9892.109710125978, 10310.278280520291, 18946.24215031411, 19022.61954760897, 19042.238310467426, 19134.61730765377, 19547.315843945395, 6795.456363490909, 6871.725130994804, 6927.7228910843005, 6983.930160698328, 7193.388561972291, 3572.160542272564, 3633.927321453556, 3648.3432982062955, 3689.981550092286, 3717.8326975286177, 2693.4343787804783, 2784.5962335461245, 2788.63747712796, 2789.246903336088, 2789.860506974643, 477.7635070639986, 539.4228175851879, 560.834553806628, 569.8632328241192, 572.948434640876, 420.78329660225006, 582.1122787748717, 597.7280337446451, 625.140431906129, 629.2511910826103, 8280.792980175544, 8524.360672949553, 8659.653613855502, 8986.281097512183, 8990.640374385082, 542.2896006231849, 550.8953298873201, 552.240669080015, 611.1688104178314, 626.8808926303988, 4071.7353372031316, 4125.711200216017, 4219.725717828332, 4283.121959998193, 4332.913341733148, 66616.0, 91908.0, 92166.53916730508, 92234.0, 96166.51916740372, 82535.17464825395, 83135.58432207801, 84452.0, 84622.5768871164, 84835.57582212049, 70317.64841175762, 72736.0, 72962.0, 76504.23495765083, 77242.61378693183, 7893.526388416713, 7952.0, 7953.8409231816195, 7991.600419978861, 8136.471129376571, 41534.0, 43108.0, 43837.123257535306, 44263.778681106385, 44357.33463998107, 39531.40702889401, 40016.1996760069, 40365.0, 40830.59169408268, 40873.182536349705, 9917.355371900803, 10094.990500949847, 10179.541920613443, 10272.178225742073, 10300.175985921258, 11462.828057578976, 11633.825492617449, 11680.94159529197, 11751.294922304689, 11935.224210426295, 10456.947715261374, 10464.0, 10666.46667666629, 11091.334519928507, 11468.94265528667, 9798.559064841957, 10208.948955255473, 10263.178945684178, 10788.136949043901, 10792.082672972885, 10417.84373234387, 10666.679999600025, 10942.726431839268, 11094.667159985212, 11097.667069987914, 8766.956165219133, 8859.202671759573, 8927.10728927128, 9015.819683606422, 9055.23030542385, 9029.593668284811, 9038.412503187272, 9094.727158185266, 9347.719568412958, 9626.422414655142], "value": 6393.05909511409, "unit": "score"}], "name": "dromaeo_css", "value": 6410.321230365496, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 113.0, 116.0, 113.0, 114.0, 112.0, 113.0, 115.0, 114.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 122.0, 123.0, 182.0, 125.0, 124.0, 144.0, 127.0, 160.0, 127.0], "value": 138.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 163.0, 160.0, 159.0, 161.0, 161.0, 161.0, 162.0, 161.0, 161.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 125.0, 78.0, 76.0, 77.0, 76.0, 103.0, 75.0], "value": 83.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 87.0, 113.0, 86.0, 86.0, 84.0, 125.0, 85.0, 85.0, 123.0], "value": 95.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 147.0, 146.0, 146.0, 147.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, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 94.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 64.0, 63.0, 63.0, 65.0, 64.0, 63.0, 64.0, 63.0], "value": 63.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 67.0, 66.0, 76.0, 65.0, 65.0, 64.0], "value": 66.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 80.0, 79.0, 86.0, 79.0, 79.0, 79.0, 79.0, 78.0, 79.0], "value": 79.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 134.0, 137.0, 140.0, 136.0, 131.0, 132.0, 132.0, 212.0, 131.0], "value": 141.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 170.0, 166.0, 164.0, 163.0, 167.0, 166.0, 165.0, 167.0, 169.0], "value": 167.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 71.0, 67.0, 70.0, 66.0, 65.0, 70.0, 67.0, 66.0, 73.0], "value": 68.8, "unit": "score"}], "name": "kraken", "value": 1537.7, "alertThreshold": 2.0}]} 16:08:35 INFO - Return code: 0 16:08:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:08:35 INFO - # TBPL SUCCESS # 16:08:35 INFO - Running post-action listener: _resource_record_post_action 16:08:35 INFO - ##### 16:08:35 INFO - ##### Finished run-tests step (success) 16:08:35 INFO - ##### 16:08:35 INFO - Running post-run listener: _resource_record_post_run 16:08:35 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 0; Write bytes: 535019520; Read time: 0; Write time: 404144 16:08:35 INFO - TinderboxPrint: CPU usage
12.9% 16:08:35 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 16:08:35 INFO - TinderboxPrint: I/O write bytes / time
535,019,520 / 404,144 16:08:35 INFO - TinderboxPrint: CPU idle
8,336.5 (87.0%) 16:08:35 INFO - TinderboxPrint: CPU user
1,199.9 (12.5%) 16:08:35 INFO - TinderboxPrint: Swap in / out
0 / 0 16:08:35 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 246435840; Read time: 0; Write time: 232368 16:08:35 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 288583680; Read time: 0; Write time: 171776 16:08:36 INFO - Running post-run listener: _upload_blobber_files 16:08:36 INFO - Blob upload gear active. 16:08:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:08:36 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 16:08:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:08:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:08:36 INFO - (blobuploader) - INFO - Open directory for files ... 16:08:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:08:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:08:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:08:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:08:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:08:37 INFO - (blobuploader) - INFO - Done attempting. 16:08:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:08:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:08:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:08:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:08:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:08:38 INFO - (blobuploader) - INFO - Done attempting. 16:08:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:08:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:08:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:08:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:08:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:08:41 INFO - (blobuploader) - INFO - Done attempting. 16:08:41 INFO - (blobuploader) - INFO - Iteration through files over. 16:08:41 INFO - Return code: 0 16:08:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:08:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:08:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/94a99151c9d9152605bc518408821ebd6e6e2cbdc530a331fc653f0e0db766a4557757158bf47b08a4ec2d5b2af4f0ef996352f64ef5ceec873db1410fcef97a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3e76983f0942e9074da7cc3cd2e8823345acdecdd26d3081d7090a6f63020545c5bbcc0f8ef9c8a356cdaa85cf423a148526100ef31fd993d811605aeb03586d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d79c0015a495c91fd9c624d15763d26d109e467c862354b9fd963a61e69d14e50144966de1ab8e77ff951fe6726f009833194bdeb8fe51b548b28423ccecd37f"} 16:08:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:08:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:08:41 INFO - Contents: 16:08:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/94a99151c9d9152605bc518408821ebd6e6e2cbdc530a331fc653f0e0db766a4557757158bf47b08a4ec2d5b2af4f0ef996352f64ef5ceec873db1410fcef97a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3e76983f0942e9074da7cc3cd2e8823345acdecdd26d3081d7090a6f63020545c5bbcc0f8ef9c8a356cdaa85cf423a148526100ef31fd993d811605aeb03586d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d79c0015a495c91fd9c624d15763d26d109e467c862354b9fd963a61e69d14e50144966de1ab8e77ff951fe6726f009833194bdeb8fe51b548b28423ccecd37f"} 16:08:41 INFO - Running post-run listener: copy_logs_to_upload_dir 16:08:41 INFO - Copying logs to upload dir... 16:08:41 INFO - mkdir: /builds/slave/test/build/upload/logs 16:08:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.529852 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-11 16:08:40.985476) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-11 16:08:40.989074) ========= 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=db7e7c15f3ca076d53731445000001ba-1468277280.281481-1978854944 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/94a99151c9d9152605bc518408821ebd6e6e2cbdc530a331fc653f0e0db766a4557757158bf47b08a4ec2d5b2af4f0ef996352f64ef5ceec873db1410fcef97a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3e76983f0942e9074da7cc3cd2e8823345acdecdd26d3081d7090a6f63020545c5bbcc0f8ef9c8a356cdaa85cf423a148526100ef31fd993d811605aeb03586d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d79c0015a495c91fd9c624d15763d26d109e467c862354b9fd963a61e69d14e50144966de1ab8e77ff951fe6726f009833194bdeb8fe51b548b28423ccecd37f"} build_url:https://queue.taskcluster.net/v1/task/QYbo5ZewSzW0uE88oHhbRA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011266 build_url: 'https://queue.taskcluster.net/v1/task/QYbo5ZewSzW0uE88oHhbRA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/94a99151c9d9152605bc518408821ebd6e6e2cbdc530a331fc653f0e0db766a4557757158bf47b08a4ec2d5b2af4f0ef996352f64ef5ceec873db1410fcef97a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3e76983f0942e9074da7cc3cd2e8823345acdecdd26d3081d7090a6f63020545c5bbcc0f8ef9c8a356cdaa85cf423a148526100ef31fd993d811605aeb03586d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d79c0015a495c91fd9c624d15763d26d109e467c862354b9fd963a61e69d14e50144966de1ab8e77ff951fe6726f009833194bdeb8fe51b548b28423ccecd37f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-11 16:08:41.014910) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 16:08:41.015262) ========= 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=db7e7c15f3ca076d53731445000001ba-1468277280.281481-1978854944 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004379 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 16:08:41.097411) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-11 16:08:41.097740) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-11 16:08:41.098041) ========= ========= Total master_lag: 0.16 =========