builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-052 starttime: 1472324090.79 results: success (0) buildid: 20160827105613 builduid: a7d3d5b3870b4914baf7ee40fca044e8 revision: 47da2b6ea281cf00b67ad4e0c53a31539a4fd10b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-27 11:54:50.787836) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-27 11:54:50.788228) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-27 11:54:50.788492) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-27 11:54:50.833703) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 11:54:50.834011) ========= 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=826874ccc97bd7bf541b4875000001d5-1472319983.608159-278233103 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-27 11:54:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.2M=0s 2016-08-27 11:54:51 (46.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120065 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 11:54:50.967527) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 11:54:50.967850) ========= 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=826874ccc97bd7bf541b4875000001d5-1472319983.608159-278233103 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014174 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 11:54:51.017582) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 11:54:51.017914) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 47da2b6ea281cf00b67ad4e0c53a31539a4fd10b --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 47da2b6ea281cf00b67ad4e0c53a31539a4fd10b --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=826874ccc97bd7bf541b4875000001d5-1472319983.608159-278233103 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-27 11:54:51,300 truncating revision to first 12 chars 2016-08-27 11:54:51,300 Setting DEBUG logging. 2016-08-27 11:54:51,300 attempt 1/10 2016-08-27 11:54:51,300 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/47da2b6ea281?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-27 11:54:51,836 unpacking tar archive at: fx-team-47da2b6ea281/testing/mozharness/ program finished with exit code 0 elapsedTime=0.893380 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 11:54:51.925479) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-27 11:54:51.925821) ========= script_repo_revision: 47da2b6ea281cf00b67ad4e0c53a31539a4fd10b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-27 11:54:51.926346) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-27 11:54:51.926720) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-27 11:54:51.938399) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-08-27 11:54:51.938768) ========= /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=826874ccc97bd7bf541b4875000001d5-1472319983.608159-278233103 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:54:52 INFO - MultiFileLogger online at 20160827 11:54:52 in /builds/slave/test 11:54:52 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 11:54:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:54:52 INFO - {'append_to_log': False, 11:54:52 INFO - 'base_work_dir': '/builds/slave/test', 11:54:52 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 11:54:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:54:52 INFO - 'branch': 'Fx-Team-Non-PGO', 11:54:52 INFO - 'buildbot_json_path': 'buildprops.json', 11:54:52 INFO - 'config_files': ('talos/linux_config.py',), 11:54:52 INFO - 'default_actions': ('clobber', 11:54:52 INFO - 'read-buildbot-config', 11:54:52 INFO - 'download-and-extract', 11:54:52 INFO - 'populate-webroot', 11:54:52 INFO - 'create-virtualenv', 11:54:52 INFO - 'install', 11:54:52 INFO - 'run-tests'), 11:54:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:54:52 INFO - 'download_minidump_stackwalk': True, 11:54:52 INFO - 'download_symbols': 'ondemand', 11:54:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:54:52 INFO - 'tooltool.py': '/tools/tooltool.py', 11:54:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:54:52 INFO - '/tools/misc-python/virtualenv.py')}, 11:54:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:54:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:54:52 INFO - 'installer_path': 'installer.exe', 11:54:52 INFO - 'log_level': 'info', 11:54:52 INFO - 'log_name': 'talos', 11:54:52 INFO - 'log_to_console': True, 11:54:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:54:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:54:52 INFO - 'opt_config_files': (), 11:54:52 INFO - 'pip_index': False, 11:54:52 INFO - 'sps_profile': False, 11:54:52 INFO - 'sps_profile_interval': 0, 11:54:52 INFO - 'suite': 'dromaeojs', 11:54:52 INFO - 'system_bits': '32', 11:54:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:54:52 INFO - 'title': 'talos-linux64-ix-052', 11:54:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:54:52 INFO - 'use_talos_json': True, 11:54:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:54:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:54:52 INFO - 'work_dir': 'build'} 11:54:52 INFO - [mozharness: 2016-08-27 18:54:52.311416Z] Running clobber step. 11:54:52 INFO - Running pre-action listener: _resource_record_pre_action 11:54:52 INFO - Running main action method: clobber 11:54:52 INFO - rmtree: /builds/slave/test/build 11:54:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:54:53 INFO - Running post-action listener: _resource_record_post_action 11:54:53 INFO - [mozharness: 2016-08-27 18:54:53.276193Z] Finished clobber step (success) 11:54:53 INFO - [mozharness: 2016-08-27 18:54:53.276294Z] Running read-buildbot-config step. 11:54:53 INFO - Running pre-action listener: _resource_record_pre_action 11:54:53 INFO - Running main action method: read_buildbot_config 11:54:53 INFO - Using buildbot properties: 11:54:53 INFO - { 11:54:53 INFO - "project": "", 11:54:53 INFO - "product": "firefox", 11:54:53 INFO - "script_repo_revision": "production", 11:54:53 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:54:53 INFO - "repository": "", 11:54:53 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 11:54:53 INFO - "buildid": "20160827105613", 11:54:53 INFO - "pgo_build": "False", 11:54:53 INFO - "basedir": "/builds/slave/test", 11:54:53 INFO - "buildnumber": 1895, 11:54:53 INFO - "slavename": "talos-linux64-ix-052", 11:54:53 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:54:53 INFO - "platform": "ubuntu64_hw", 11:54:53 INFO - "scheduler": "tests-fx-team-linux64-talos", 11:54:53 INFO - "branch": "fx-team", 11:54:53 INFO - "repo_path": "integration/fx-team", 11:54:53 INFO - "revision": "47da2b6ea281cf00b67ad4e0c53a31539a4fd10b", 11:54:53 INFO - "stage_platform": "linux64", 11:54:53 INFO - "builduid": "a7d3d5b3870b4914baf7ee40fca044e8", 11:54:53 INFO - "slavebuilddir": "test" 11:54:53 INFO - } 11:54:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/CCJe1_2gQjGZYmq1Y0tKqQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 11:54:53 INFO - Running post-action listener: _resource_record_post_action 11:54:53 INFO - [mozharness: 2016-08-27 18:54:53.278738Z] Finished read-buildbot-config step (success) 11:54:53 INFO - [mozharness: 2016-08-27 18:54:53.278828Z] Running download-and-extract step. 11:54:53 INFO - Running pre-action listener: _resource_record_pre_action 11:54:53 INFO - Running main action method: download_and_extract 11:54:53 INFO - mkdir: /builds/slave/test/build/tests 11:54:53 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:54:53 INFO - trying https://queue.taskcluster.net/v1/task/CCJe1_2gQjGZYmq1Y0tKqQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:54:53 INFO - Downloading https://queue.taskcluster.net/v1/task/CCJe1_2gQjGZYmq1Y0tKqQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:54:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CCJe1_2gQjGZYmq1Y0tKqQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:54:53 INFO - Downloaded 1361 bytes. 11:54:53 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:54:53 INFO - Using the following test package requirements: 11:54:53 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 11:54:53 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:54:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:54:53 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:54:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:54:53 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:54:53 INFO - u'jsshell-linux-x86_64.zip'], 11:54:53 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:54:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:54:53 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 11:54:53 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:54:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:54:53 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:54:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:54:53 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:54:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:54:53 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:54:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:54:53 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:54:53 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:54:53 INFO - trying https://queue.taskcluster.net/v1/task/CCJe1_2gQjGZYmq1Y0tKqQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:54:53 INFO - Downloading https://queue.taskcluster.net/v1/task/CCJe1_2gQjGZYmq1Y0tKqQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:54:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CCJe1_2gQjGZYmq1Y0tKqQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:54:54 INFO - Downloaded 20304670 bytes. 11:54:54 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 11:54:58 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:54:58 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:54:58 INFO - trying https://queue.taskcluster.net/v1/task/CCJe1_2gQjGZYmq1Y0tKqQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:54:58 INFO - Downloading https://queue.taskcluster.net/v1/task/CCJe1_2gQjGZYmq1Y0tKqQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:54:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CCJe1_2gQjGZYmq1Y0tKqQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:54:59 INFO - Downloaded 20304670 bytes. 11:54:59 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 11:55:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:04 INFO - trying https://queue.taskcluster.net/v1/task/CCJe1_2gQjGZYmq1Y0tKqQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 11:55:04 INFO - Downloading https://queue.taskcluster.net/v1/task/CCJe1_2gQjGZYmq1Y0tKqQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 11:55:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CCJe1_2gQjGZYmq1Y0tKqQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:55:05 INFO - Downloaded 14413998 bytes. 11:55:05 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 11:55:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:05 INFO - trying https://queue.taskcluster.net/v1/task/CCJe1_2gQjGZYmq1Y0tKqQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:55:05 INFO - Downloading https://queue.taskcluster.net/v1/task/CCJe1_2gQjGZYmq1Y0tKqQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:55:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CCJe1_2gQjGZYmq1Y0tKqQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:55:07 INFO - Downloaded 55862870 bytes. 11:55:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CCJe1_2gQjGZYmq1Y0tKqQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:55:07 INFO - mkdir: /builds/slave/test/properties 11:55:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:55:07 INFO - Writing to file /builds/slave/test/properties/build_url 11:55:07 INFO - Contents: 11:55:07 INFO - build_url:https://queue.taskcluster.net/v1/task/CCJe1_2gQjGZYmq1Y0tKqQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:55:08 INFO - Running post-action listener: _resource_record_post_action 11:55:08 INFO - Running post-action listener: set_extra_try_arguments 11:55:08 INFO - [mozharness: 2016-08-27 18:55:08.667219Z] Finished download-and-extract step (success) 11:55:08 INFO - [mozharness: 2016-08-27 18:55:08.667447Z] Running populate-webroot step. 11:55:08 INFO - Running pre-action listener: _resource_record_pre_action 11:55:08 INFO - Running main action method: populate_webroot 11:55:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:55:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:55:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:55:08 INFO - '--tppagecycles', 11:55:08 INFO - '7'], 11:55:08 INFO - 'tests': ['tsvgm']}}, 11:55:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:55:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:55:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:55:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:55:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:55:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:55:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:55:08 INFO - 'talos_options': ['--disable-e10s'], 11:55:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:55:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:55:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:55:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:55:08 INFO - 'talos_options': ['--disable-e10s'], 11:55:08 INFO - 'tests': ['damp', 'tps']}, 11:55:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:55:08 INFO - 'tests': ['damp', 'tps']}, 11:55:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:55:08 INFO - 'tests': ['dromaeo_dom']}, 11:55:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:55:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:55:08 INFO - 'tests': ['basic_compositor_video']}, 11:55:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:55:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:55:08 INFO - 'tests': ['a11yr', 11:55:08 INFO - 'ts_paint', 11:55:08 INFO - 'tpaint', 11:55:08 INFO - 'sessionrestore', 11:55:08 INFO - 'sessionrestore_no_auto_restore', 11:55:08 INFO - 'tabpaint']}, 11:55:08 INFO - 'other-e10s': {'tests': ['a11yr', 11:55:08 INFO - 'ts_paint', 11:55:08 INFO - 'tpaint', 11:55:08 INFO - 'sessionrestore', 11:55:08 INFO - 'sessionrestore_no_auto_restore', 11:55:08 INFO - 'tabpaint']}, 11:55:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:55:08 INFO - 'ts_paint', 11:55:08 INFO - 'tpaint', 11:55:08 INFO - 'sessionrestore', 11:55:08 INFO - 'sessionrestore_no_auto_restore', 11:55:08 INFO - 'tabpaint']}, 11:55:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:55:08 INFO - 'ts_paint', 11:55:08 INFO - 'tpaint', 11:55:08 INFO - 'sessionrestore', 11:55:08 INFO - 'sessionrestore_no_auto_restore', 11:55:08 INFO - 'tabpaint']}, 11:55:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:55:08 INFO - 'tests': ['a11yr', 11:55:08 INFO - 'ts_paint', 11:55:08 INFO - 'tpaint', 11:55:08 INFO - 'sessionrestore', 11:55:08 INFO - 'sessionrestore_no_auto_restore', 11:55:08 INFO - 'tabpaint']}, 11:55:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:55:08 INFO - 'tests': ['a11yr', 11:55:08 INFO - 'ts_paint', 11:55:08 INFO - 'tpaint', 11:55:08 INFO - 'sessionrestore', 11:55:08 INFO - 'sessionrestore_no_auto_restore', 11:55:08 INFO - 'tabpaint']}, 11:55:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:55:08 INFO - 'tests': ['tsvgx', 11:55:08 INFO - 'tsvgr_opacity', 11:55:08 INFO - 'tart', 11:55:08 INFO - 'tscrollx', 11:55:08 INFO - 'cart']}, 11:55:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:55:08 INFO - 'tsvgr_opacity', 11:55:08 INFO - 'tart', 11:55:08 INFO - 'tscrollx', 11:55:08 INFO - 'cart']}, 11:55:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:55:08 INFO - 'talos_options': ['--disable-e10s'], 11:55:08 INFO - 'tests': ['tp5o']}, 11:55:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:55:08 INFO - 'tests': ['tp5o']}, 11:55:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:55:08 INFO - 'talos_options': ['--disable-e10s', 11:55:08 INFO - '--xperf_path', 11:55:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:55:08 INFO - 'tests': ['tp5n']}, 11:55:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:55:08 INFO - 'talos_options': ['--xperf_path', 11:55:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:55:08 INFO - 'tests': ['tp5n']}}, 11:55:08 INFO - 'talos.zip': {'path': '', 11:55:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:55:08 INFO - Running post-action listener: _resource_record_post_action 11:55:08 INFO - [mozharness: 2016-08-27 18:55:08.686975Z] Finished populate-webroot step (success) 11:55:08 INFO - [mozharness: 2016-08-27 18:55:08.687065Z] Running create-virtualenv step. 11:55:08 INFO - Running pre-action listener: _resource_record_pre_action 11:55:08 INFO - Running main action method: create_virtualenv 11:55:08 INFO - Creating virtualenv /builds/slave/test/build/venv 11:55:08 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 11:55:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:55:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:55:08 INFO - Using real prefix '/usr' 11:55:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:55:09 INFO - Installing distribute.............................................................................................................................................................................................done. 11:55:11 INFO - Installing pip.................done. 11:55:11 INFO - Return code: 0 11:55:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:55:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd271ff5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf70230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6a090>, '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 0xf6d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6de40>, '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': '826874ccc97bd7bf541b4875000001d5-1472319983.608159-278233103', '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 11:55:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:55:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:55:11 INFO - Using env: {'DISPLAY': ':0', 11:55:11 INFO - 'HOME': '/home/cltbld', 11:55:11 INFO - 'LANG': 'en_US.UTF-8', 11:55:11 INFO - 'LANGUAGE': 'en_US:en', 11:55:11 INFO - 'LOGNAME': 'cltbld', 11:55:11 INFO - 'MAIL': '/var/mail/cltbld', 11:55:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:11 INFO - 'MOZ_NO_REMOTE': '1', 11:55:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:55:11 INFO - 'NO_EM_RESTART': '1', 11:55:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:55:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:11 INFO - 'PWD': '/builds/slave/test', 11:55:11 INFO - 'SHELL': '/bin/bash', 11:55:11 INFO - 'SHLVL': '1', 11:55:11 INFO - 'TERM': 'linux', 11:55:11 INFO - 'TMOUT': '86400', 11:55:11 INFO - 'USER': 'cltbld', 11:55:11 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1472319983.608159-278233103', 11:55:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:11 INFO - '_': '/tools/buildbot/bin/python'} 11:55:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:11 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 11:55:11 INFO - Cleaning up... 11:55:11 INFO - Return code: 0 11:55:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:55:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd271ff5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf70230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6a090>, '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 0xf6d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6de40>, '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': '826874ccc97bd7bf541b4875000001d5-1472319983.608159-278233103', '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 11:55:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:55:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:55:11 INFO - Using env: {'DISPLAY': ':0', 11:55:11 INFO - 'HOME': '/home/cltbld', 11:55:11 INFO - 'LANG': 'en_US.UTF-8', 11:55:11 INFO - 'LANGUAGE': 'en_US:en', 11:55:11 INFO - 'LOGNAME': 'cltbld', 11:55:11 INFO - 'MAIL': '/var/mail/cltbld', 11:55:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:11 INFO - 'MOZ_NO_REMOTE': '1', 11:55:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:55:11 INFO - 'NO_EM_RESTART': '1', 11:55:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:55:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:11 INFO - 'PWD': '/builds/slave/test', 11:55:11 INFO - 'SHELL': '/bin/bash', 11:55:11 INFO - 'SHLVL': '1', 11:55:11 INFO - 'TERM': 'linux', 11:55:11 INFO - 'TMOUT': '86400', 11:55:11 INFO - 'USER': 'cltbld', 11:55:11 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1472319983.608159-278233103', 11:55:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:11 INFO - '_': '/tools/buildbot/bin/python'} 11:55:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:11 INFO - Downloading/unpacking psutil>=3.1.1 11:55:11 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 11:55:11 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 11:55:11 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 11:55:11 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 11:55:11 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 11:55:11 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 11:55:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:55:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:55:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:55:13 INFO - Installing collected packages: psutil 11:55:13 INFO - Running setup.py install for psutil 11:55:13 INFO - building 'psutil._psutil_linux' extension 11:55:13 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 11:55:13 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 11:55:13 INFO - building 'psutil._psutil_posix' extension 11:55:13 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 11:55:14 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 11:55:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:55:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:55:14 INFO - Successfully installed psutil 11:55:14 INFO - Cleaning up... 11:55:14 INFO - Return code: 0 11:55:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:55:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:14 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 0x7fd271ff5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf70230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6a090>, '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 0xf6d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6de40>, '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': '826874ccc97bd7bf541b4875000001d5-1472319983.608159-278233103', '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 11:55:14 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 11:55:14 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 11:55:14 INFO - Using env: {'DISPLAY': ':0', 11:55:14 INFO - 'HOME': '/home/cltbld', 11:55:14 INFO - 'LANG': 'en_US.UTF-8', 11:55:14 INFO - 'LANGUAGE': 'en_US:en', 11:55:14 INFO - 'LOGNAME': 'cltbld', 11:55:14 INFO - 'MAIL': '/var/mail/cltbld', 11:55:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:14 INFO - 'MOZ_NO_REMOTE': '1', 11:55:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:55:14 INFO - 'NO_EM_RESTART': '1', 11:55:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:55:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:14 INFO - 'PWD': '/builds/slave/test', 11:55:14 INFO - 'SHELL': '/bin/bash', 11:55:14 INFO - 'SHLVL': '1', 11:55:14 INFO - 'TERM': 'linux', 11:55:14 INFO - 'TMOUT': '86400', 11:55:14 INFO - 'USER': 'cltbld', 11:55:14 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1472319983.608159-278233103', 11:55:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:14 INFO - '_': '/tools/buildbot/bin/python'} 11:55:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:55:14 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 11:55:14 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 11:55:14 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 11:55:14 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 11:55:14 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 11:55:14 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 11:55:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:55:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:55:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:55:16 INFO - Installing collected packages: mozsystemmonitor 11:55:16 INFO - Running setup.py install for mozsystemmonitor 11:55:16 INFO - Successfully installed mozsystemmonitor 11:55:16 INFO - Cleaning up... 11:55:16 INFO - Return code: 0 11:55:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:55:16 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:16 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:16 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 0x7fd271ff5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf70230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6a090>, '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 0xf6d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6de40>, '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': '826874ccc97bd7bf541b4875000001d5-1472319983.608159-278233103', '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 11:55:16 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 11:55:16 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 11:55:16 INFO - Using env: {'DISPLAY': ':0', 11:55:16 INFO - 'HOME': '/home/cltbld', 11:55:16 INFO - 'LANG': 'en_US.UTF-8', 11:55:16 INFO - 'LANGUAGE': 'en_US:en', 11:55:16 INFO - 'LOGNAME': 'cltbld', 11:55:16 INFO - 'MAIL': '/var/mail/cltbld', 11:55:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:16 INFO - 'MOZ_NO_REMOTE': '1', 11:55:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:55:16 INFO - 'NO_EM_RESTART': '1', 11:55:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:55:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:16 INFO - 'PWD': '/builds/slave/test', 11:55:16 INFO - 'SHELL': '/bin/bash', 11:55:16 INFO - 'SHLVL': '1', 11:55:16 INFO - 'TERM': 'linux', 11:55:16 INFO - 'TMOUT': '86400', 11:55:16 INFO - 'USER': 'cltbld', 11:55:16 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1472319983.608159-278233103', 11:55:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:16 INFO - '_': '/tools/buildbot/bin/python'} 11:55:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:16 INFO - Downloading/unpacking jsonschema==2.5.1 11:55: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 11:55: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 11:55: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 11:55: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 11:55: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 11:55: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 11:55:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:55:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:55: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 11:55: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 11:55: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 11:55: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 11:55: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 11:55: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 11:55:18 INFO - Downloading functools32-3.2.3-2.tar.gz 11:55:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:55:18 INFO - warning: no files found matching '*.txt' 11:55:18 INFO - no previously-included directories found matching 'build' 11:55:18 INFO - no previously-included directories found matching 'dist' 11:55:18 INFO - no previously-included directories found matching '.git*' 11:55:18 INFO - Installing collected packages: jsonschema, functools32 11:55:18 INFO - Running setup.py install for functools32 11:55:19 INFO - warning: no files found matching '*.txt' 11:55:19 INFO - no previously-included directories found matching 'build' 11:55:19 INFO - no previously-included directories found matching 'dist' 11:55:19 INFO - no previously-included directories found matching '.git*' 11:55:19 INFO - Successfully installed jsonschema functools32 11:55:19 INFO - Cleaning up... 11:55:19 INFO - Return code: 0 11:55:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:55:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd271ff5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf70230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6a090>, '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 0xf6d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6de40>, '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': '826874ccc97bd7bf541b4875000001d5-1472319983.608159-278233103', '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 11:55:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:55:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:55:19 INFO - Using env: {'DISPLAY': ':0', 11:55:19 INFO - 'HOME': '/home/cltbld', 11:55:19 INFO - 'LANG': 'en_US.UTF-8', 11:55:19 INFO - 'LANGUAGE': 'en_US:en', 11:55:19 INFO - 'LOGNAME': 'cltbld', 11:55:19 INFO - 'MAIL': '/var/mail/cltbld', 11:55:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:19 INFO - 'MOZ_NO_REMOTE': '1', 11:55:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:55:19 INFO - 'NO_EM_RESTART': '1', 11:55:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:55:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:19 INFO - 'PWD': '/builds/slave/test', 11:55:19 INFO - 'SHELL': '/bin/bash', 11:55:19 INFO - 'SHLVL': '1', 11:55:19 INFO - 'TERM': 'linux', 11:55:19 INFO - 'TMOUT': '86400', 11:55:19 INFO - 'USER': 'cltbld', 11:55:19 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1472319983.608159-278233103', 11:55:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:19 INFO - '_': '/tools/buildbot/bin/python'} 11:55:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:55:19 INFO - Cleaning up... 11:55:19 INFO - Return code: 0 11:55:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:55:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd271ff5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf70230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6a090>, '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 0xf6d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6de40>, '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': '826874ccc97bd7bf541b4875000001d5-1472319983.608159-278233103', '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 11:55:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:55:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:55:19 INFO - Using env: {'DISPLAY': ':0', 11:55:19 INFO - 'HOME': '/home/cltbld', 11:55:19 INFO - 'LANG': 'en_US.UTF-8', 11:55:19 INFO - 'LANGUAGE': 'en_US:en', 11:55:19 INFO - 'LOGNAME': 'cltbld', 11:55:19 INFO - 'MAIL': '/var/mail/cltbld', 11:55:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:19 INFO - 'MOZ_NO_REMOTE': '1', 11:55:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:55:19 INFO - 'NO_EM_RESTART': '1', 11:55:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:55:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:19 INFO - 'PWD': '/builds/slave/test', 11:55:19 INFO - 'SHELL': '/bin/bash', 11:55:19 INFO - 'SHLVL': '1', 11:55:19 INFO - 'TERM': 'linux', 11:55:19 INFO - 'TMOUT': '86400', 11:55:19 INFO - 'USER': 'cltbld', 11:55:19 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1472319983.608159-278233103', 11:55:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:19 INFO - '_': '/tools/buildbot/bin/python'} 11:55:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:19 INFO - Downloading/unpacking blobuploader==1.2.4 11:55:19 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 11:55:19 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 11:55:19 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 11:55:19 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 11:55:19 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 11:55:19 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 11:55:21 INFO - Downloading blobuploader-1.2.4.tar.gz 11:55:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:55:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:55: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 11:55: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 11:55: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 11:55: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 11:55: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 11:55: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 11:55:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:55:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:55:22 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 11:55:22 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 11:55:22 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 11:55:22 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 11:55:22 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 11:55:22 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 11:55:22 INFO - Downloading docopt-0.6.1.tar.gz 11:55:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:55:22 INFO - Installing collected packages: blobuploader, requests, docopt 11:55:22 INFO - Running setup.py install for blobuploader 11:55:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:55:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:55:22 INFO - Running setup.py install for requests 11:55:22 INFO - Running setup.py install for docopt 11:55:22 INFO - Successfully installed blobuploader requests docopt 11:55:22 INFO - Cleaning up... 11:55:22 INFO - Return code: 0 11:55:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:55:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:22 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 0x7fd271ff5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf70230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6a090>, '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 0xf6d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6de40>, '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': '826874ccc97bd7bf541b4875000001d5-1472319983.608159-278233103', '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 11:55:22 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 11:55:22 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 11:55:22 INFO - Using env: {'DISPLAY': ':0', 11:55:22 INFO - 'HOME': '/home/cltbld', 11:55:22 INFO - 'LANG': 'en_US.UTF-8', 11:55:22 INFO - 'LANGUAGE': 'en_US:en', 11:55:22 INFO - 'LOGNAME': 'cltbld', 11:55:22 INFO - 'MAIL': '/var/mail/cltbld', 11:55:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:22 INFO - 'MOZ_NO_REMOTE': '1', 11:55:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:55:22 INFO - 'NO_EM_RESTART': '1', 11:55:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:55:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:22 INFO - 'PWD': '/builds/slave/test', 11:55:22 INFO - 'SHELL': '/bin/bash', 11:55:22 INFO - 'SHLVL': '1', 11:55:22 INFO - 'TERM': 'linux', 11:55:22 INFO - 'TMOUT': '86400', 11:55:22 INFO - 'USER': 'cltbld', 11:55:22 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1472319983.608159-278233103', 11:55:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:22 INFO - '_': '/tools/buildbot/bin/python'} 11:55:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:55:23 INFO - Running setup.py (path:/tmp/pip-KuUBf0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:55:23 INFO - Running setup.py (path:/tmp/pip-_wx8Uj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:55:23 INFO - Running setup.py (path:/tmp/pip-x52m8V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:55:23 INFO - Running setup.py (path:/tmp/pip-NrYRQo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:55:23 INFO - Running setup.py (path:/tmp/pip-qOT52U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:55:23 INFO - Running setup.py (path:/tmp/pip-RjB2aa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:55:23 INFO - Running setup.py (path:/tmp/pip-lVIWWl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:55:23 INFO - Running setup.py (path:/tmp/pip-OrDgjq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:55:23 INFO - Running setup.py (path:/tmp/pip-Ny6KTp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:55:23 INFO - Running setup.py (path:/tmp/pip-FA9MPJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:55:23 INFO - Running setup.py (path:/tmp/pip-iq60gS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:55:23 INFO - Running setup.py (path:/tmp/pip-KpSrBK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:55:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:55:24 INFO - Running setup.py (path:/tmp/pip-AvTAyH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:55:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:55:24 INFO - Running setup.py (path:/tmp/pip-lUtp0z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:55:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:55:24 INFO - Running setup.py (path:/tmp/pip-yjVSoC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:55:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:55:24 INFO - Running setup.py (path:/tmp/pip-JdHFck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:55:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:55:24 INFO - Running setup.py (path:/tmp/pip-7NsYav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:55:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:55:24 INFO - Running setup.py install for manifestparser 11:55:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:55:24 INFO - Running setup.py install for mozcrash 11:55:24 INFO - Running setup.py install for mozdebug 11:55:24 INFO - Running setup.py install for mozdevice 11:55:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:55:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:55:24 INFO - Running setup.py install for mozfile 11:55:24 INFO - Running setup.py install for mozhttpd 11:55:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:55:25 INFO - Running setup.py install for mozinfo 11:55:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:55:25 INFO - Running setup.py install for mozInstall 11:55:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:55:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:55:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:55:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:55:25 INFO - Running setup.py install for mozleak 11:55:25 INFO - Running setup.py install for mozlog 11:55:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:55:25 INFO - Running setup.py install for moznetwork 11:55:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:55:25 INFO - Running setup.py install for mozprocess 11:55:25 INFO - Running setup.py install for mozprofile 11:55:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:55:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:55:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:55:25 INFO - Running setup.py install for mozrunner 11:55:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:55:25 INFO - Running setup.py install for mozscreenshot 11:55:25 INFO - Running setup.py install for moztest 11:55:26 INFO - Running setup.py install for mozversion 11:55:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:55:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:55:26 INFO - Cleaning up... 11:55:26 INFO - Return code: 0 11:55:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:55:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:26 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 0x7fd271ff5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf70230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6a090>, '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 0xf6d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6de40>, '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': '826874ccc97bd7bf541b4875000001d5-1472319983.608159-278233103', '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 11:55:26 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 11:55:26 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 11:55:26 INFO - Using env: {'DISPLAY': ':0', 11:55:26 INFO - 'HOME': '/home/cltbld', 11:55:26 INFO - 'LANG': 'en_US.UTF-8', 11:55:26 INFO - 'LANGUAGE': 'en_US:en', 11:55:26 INFO - 'LOGNAME': 'cltbld', 11:55:26 INFO - 'MAIL': '/var/mail/cltbld', 11:55:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:26 INFO - 'MOZ_NO_REMOTE': '1', 11:55:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:55:26 INFO - 'NO_EM_RESTART': '1', 11:55:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:55:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:26 INFO - 'PWD': '/builds/slave/test', 11:55:26 INFO - 'SHELL': '/bin/bash', 11:55:26 INFO - 'SHLVL': '1', 11:55:26 INFO - 'TERM': 'linux', 11:55:26 INFO - 'TMOUT': '86400', 11:55:26 INFO - 'USER': 'cltbld', 11:55:26 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1472319983.608159-278233103', 11:55:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:26 INFO - '_': '/tools/buildbot/bin/python'} 11:55:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:55:26 INFO - Running setup.py (path:/tmp/pip-QldUIk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:55:26 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)) 11:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:55:26 INFO - Running setup.py (path:/tmp/pip-anmPPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:55:26 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)) 11:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:55:26 INFO - Running setup.py (path:/tmp/pip-DE0tI8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:55:26 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)) 11:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:55:26 INFO - Running setup.py (path:/tmp/pip-Q4jbUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:55:26 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)) 11:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:55:26 INFO - Running setup.py (path:/tmp/pip-Vgy58U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:55:26 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)) 11:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:55:26 INFO - Running setup.py (path:/tmp/pip-BJVDcd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:55:26 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)) 11:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:55:26 INFO - Running setup.py (path:/tmp/pip-awytx4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:55:26 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)) 11:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:55:26 INFO - Running setup.py (path:/tmp/pip-q3_oDh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:55:26 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)) 11:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:55:26 INFO - Running setup.py (path:/tmp/pip-XhBXry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:55:27 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)) 11:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:55:27 INFO - Running setup.py (path:/tmp/pip-vEtBwI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:55:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 11:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:55:27 INFO - Running setup.py (path:/tmp/pip-n4AyCB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:55:27 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)) 11:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:55:27 INFO - Running setup.py (path:/tmp/pip-rMsNAw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:55:27 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)) 11:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:55:27 INFO - Running setup.py (path:/tmp/pip-B0W6lj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:55:27 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)) 11:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:55:27 INFO - Running setup.py (path:/tmp/pip-M5HHiU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:55:27 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)) 11:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:55:27 INFO - Running setup.py (path:/tmp/pip-yZMxO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:55:27 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)) 11:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:55:27 INFO - Running setup.py (path:/tmp/pip-srNU6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:55:27 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)) 11:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:55:27 INFO - Running setup.py (path:/tmp/pip-ymn1Gk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:55:27 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)) 11:55:27 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)) 11:55:27 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)) 11:55:27 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)) 11:55:27 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)) 11:55:27 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)) 11:55:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:55:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:55:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:55:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:55:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:55:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:55:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:55:29 INFO - Downloading blessings-1.6.tar.gz 11:55:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:55:29 INFO - Installing collected packages: blessings 11:55:29 INFO - Running setup.py install for blessings 11:55:29 INFO - Successfully installed blessings 11:55:29 INFO - Cleaning up... 11:55:29 INFO - Return code: 0 11:55:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:55:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:55:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:55:30 INFO - Reading from file tmpfile_stdout 11:55:30 INFO - Current package versions: 11:55:30 INFO - argparse == 1.2.1 11:55:30 INFO - blessings == 1.6 11:55:30 INFO - blobuploader == 1.2.4 11:55:30 INFO - docopt == 0.6.1 11:55:30 INFO - functools32 == 3.2.3-2 11:55:30 INFO - jsonschema == 2.5.1 11:55:30 INFO - manifestparser == 1.1 11:55:30 INFO - mozInstall == 1.12 11:55:30 INFO - mozcrash == 0.17 11:55:30 INFO - mozdebug == 0.1 11:55:30 INFO - mozdevice == 0.48 11:55:30 INFO - mozfile == 1.2 11:55:30 INFO - mozhttpd == 0.7 11:55:30 INFO - mozinfo == 0.9 11:55:30 INFO - mozleak == 0.1 11:55:30 INFO - mozlog == 3.3 11:55:30 INFO - moznetwork == 0.27 11:55:30 INFO - mozprocess == 0.23 11:55:30 INFO - mozprofile == 0.28 11:55:30 INFO - mozrunner == 6.12 11:55:30 INFO - mozscreenshot == 0.1 11:55:30 INFO - mozsystemmonitor == 0.3 11:55:30 INFO - moztest == 0.7 11:55:30 INFO - mozversion == 1.4 11:55:30 INFO - psutil == 3.1.1 11:55:30 INFO - requests == 1.2.3 11:55:30 INFO - wsgiref == 0.1.2 11:55:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:55: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:30 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 0x7fd271ff5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf70230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6a090>, '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 0xf6d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6de40>, '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': '826874ccc97bd7bf541b4875000001d5-1472319983.608159-278233103', '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 11:55:30 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 11:55:30 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 11:55:30 INFO - Using env: {'DISPLAY': ':0', 11:55:30 INFO - 'HOME': '/home/cltbld', 11:55:30 INFO - 'LANG': 'en_US.UTF-8', 11:55:30 INFO - 'LANGUAGE': 'en_US:en', 11:55:30 INFO - 'LOGNAME': 'cltbld', 11:55:30 INFO - 'MAIL': '/var/mail/cltbld', 11:55:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:30 INFO - 'MOZ_NO_REMOTE': '1', 11:55:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:55:30 INFO - 'NO_EM_RESTART': '1', 11:55:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:55:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:30 INFO - 'PWD': '/builds/slave/test', 11:55:30 INFO - 'SHELL': '/bin/bash', 11:55:30 INFO - 'SHLVL': '1', 11:55:30 INFO - 'TERM': 'linux', 11:55:30 INFO - 'TMOUT': '86400', 11:55:30 INFO - 'USER': 'cltbld', 11:55:30 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1472319983.608159-278233103', 11:55:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:30 INFO - '_': '/tools/buildbot/bin/python'} 11:55:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:30 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)) 11:55:30 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)) 11:55:30 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)) 11:55:30 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)) 11:55:30 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)) 11:55:30 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)) 11:55:30 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)) 11:55:30 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)) 11:55:30 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)) 11:55:30 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)) 11:55:30 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)) 11:55:30 INFO - Cleaning up... 11:55:30 INFO - Return code: 0 11:55:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:55: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:30 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 0x7fd271ff5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf70230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6a090>, '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 0xf6d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6de40>, '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': '826874ccc97bd7bf541b4875000001d5-1472319983.608159-278233103', '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 11:55:30 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 11:55:30 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 11:55:30 INFO - Using env: {'DISPLAY': ':0', 11:55:30 INFO - 'HOME': '/home/cltbld', 11:55:30 INFO - 'LANG': 'en_US.UTF-8', 11:55:30 INFO - 'LANGUAGE': 'en_US:en', 11:55:30 INFO - 'LOGNAME': 'cltbld', 11:55:30 INFO - 'MAIL': '/var/mail/cltbld', 11:55:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:30 INFO - 'MOZ_NO_REMOTE': '1', 11:55:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:55:30 INFO - 'NO_EM_RESTART': '1', 11:55:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:55:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:30 INFO - 'PWD': '/builds/slave/test', 11:55:30 INFO - 'SHELL': '/bin/bash', 11:55:30 INFO - 'SHLVL': '1', 11:55:30 INFO - 'TERM': 'linux', 11:55:30 INFO - 'TMOUT': '86400', 11:55:30 INFO - 'USER': 'cltbld', 11:55:30 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1472319983.608159-278233103', 11:55:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:30 INFO - '_': '/tools/buildbot/bin/python'} 11:55:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:55:30 INFO - Cleaning up... 11:55:30 INFO - Return code: 0 11:55:30 INFO - Running post-action listener: _resource_record_post_action 11:55:30 INFO - Running post-action listener: _start_resource_monitoring 11:55:30 INFO - Starting resource monitoring. 11:55:30 INFO - [mozharness: 2016-08-27 18:55:30.493117Z] Finished create-virtualenv step (success) 11:55:30 INFO - [mozharness: 2016-08-27 18:55:30.493738Z] Running install step. 11:55:30 INFO - Running pre-action listener: _resource_record_pre_action 11:55:30 INFO - Running main action method: install 11:55:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:55:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:55:30 INFO - Reading from file tmpfile_stdout 11:55:30 INFO - Detecting whether we're running mozinstall >=1.0... 11:55:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:55:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:55:30 INFO - Reading from file tmpfile_stdout 11:55:30 INFO - Output received: 11:55:30 INFO - Usage: mozinstall [options] installer 11:55:30 INFO - Options: 11:55:30 INFO - -h, --help show this help message and exit 11:55:30 INFO - -d DEST, --destination=DEST 11:55:30 INFO - Directory to install application into. [default: 11:55:30 INFO - "/builds/slave/test"] 11:55:30 INFO - --app=APP Application being installed. [default: firefox] 11:55:30 INFO - mkdir: /builds/slave/test/build/application 11:55:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:55:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:55:47 INFO - Reading from file tmpfile_stdout 11:55:47 INFO - Output received: 11:55:47 INFO - /builds/slave/test/build/application/firefox/firefox 11:55:47 INFO - Running post-action listener: _resource_record_post_action 11:55:47 INFO - [mozharness: 2016-08-27 18:55:47.460261Z] Finished install step (success) 11:55:47 INFO - [mozharness: 2016-08-27 18:55:47.460516Z] Running run-tests step. 11:55:47 INFO - Running pre-action listener: _resource_record_pre_action 11:55:47 INFO - Running main action method: run_tests 11:55:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:55:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:55:47 INFO - Python 2.7.3 11:55:47 INFO - Return code: 0 11:55:47 INFO - grabbing minidump binary from tooltool 11:55:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:47 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 0xf6a090>, '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 0xf6d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6de40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:55:47 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 11:55:47 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 11:55:47 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 11:55:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:55:47 INFO - Return code: 0 11:55:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:55:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:55:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:55:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:55:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:55:47 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/CCJe1_2gQjGZYmq1Y0tKqQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--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 11:55:47 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/CCJe1_2gQjGZYmq1Y0tKqQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-052 --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 11:55:47 INFO - Using env: {'DISPLAY': ':0', 11:55:47 INFO - 'HOME': '/home/cltbld', 11:55:47 INFO - 'LANG': 'en_US.UTF-8', 11:55:47 INFO - 'LANGUAGE': 'en_US:en', 11:55:47 INFO - 'LOGNAME': 'cltbld', 11:55:47 INFO - 'MAIL': '/var/mail/cltbld', 11:55:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:55:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:55:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:47 INFO - 'MOZ_NO_REMOTE': '1', 11:55:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:55:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:55:47 INFO - 'NO_EM_RESTART': '1', 11:55:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:55:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:47 INFO - 'PWD': '/builds/slave/test', 11:55:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:55:47 INFO - 'SHELL': '/bin/bash', 11:55:47 INFO - 'SHLVL': '1', 11:55:47 INFO - 'TERM': 'linux', 11:55:47 INFO - 'TMOUT': '86400', 11:55:47 INFO - 'USER': 'cltbld', 11:55:47 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1472319983.608159-278233103', 11:55:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:47 INFO - '_': '/tools/buildbot/bin/python'} 11:55:47 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/CCJe1_2gQjGZYmq1Y0tKqQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--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 11:55:47 INFO - mozversion application_buildid: 20160827105613 11:55:47 INFO - mozversion application_changeset: 47da2b6ea281cf00b67ad4e0c53a31539a4fd10b 11:55:47 INFO - mozversion application_display_name: Nightly 11:55:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:55:47 INFO - mozversion application_name: Firefox 11:55:47 INFO - mozversion application_remotingname: firefox 11:55:47 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:55:47 INFO - mozversion application_vendor: Mozilla 11:55:47 INFO - mozversion application_version: 51.0a1 11:55:47 INFO - mozversion platform_buildid: 20160827105613 11:55:47 INFO - mozversion platform_changeset: 47da2b6ea281cf00b67ad4e0c53a31539a4fd10b 11:55:47 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:55:47 INFO - mozversion platform_version: 51.0a1 11:55:47 INFO - using testdate: 1472324147 11:55:47 INFO - actual date: 1472324147 11:55:47 INFO - starting webserver on 'localhost:57488' 11:55:47 INFO - SUITE-START | Running 2 tests 11:55:47 INFO - TEST-START | dromaeo_css 11:55:47 INFO - operating with platform_type : linux_ 11:55:47 INFO - Initialising browser for dromaeo_css test... 11:55:47 INFO - TEST-INFO | started process 12551 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwgOnOU/profile http://localhost:57488/getInfo.html) 11:55:51 INFO - PROCESS | 12551 | __metrics Screen width/height:1600/1200 11:55:52 INFO - PROCESS | 12551 | colorDepth:24 11:55:52 INFO - PROCESS | 12551 | Browser inner width/height: 1024/697 11:55:52 INFO - PROCESS | 12551 | __metrics 11:55:52 INFO - PROCESS | 12551 | 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" 11:55:52 INFO - PROCESS | 12551 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:55:53 INFO - TEST-INFO | 12551: exit 0 11:55:53 INFO - Browser initialized. 11:55:53 INFO - Running cycle 1/1 for dromaeo_css test... 11:55:53 INFO - TEST-INFO | started process 12631 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwgOnOU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:56:06 INFO - PROCESS | 12631 | RSS: Main: 182218752 11:56:06 INFO - PROCESS | 12631 | 11:56:57 INFO - PROCESS | 12631 | 1472324217500 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] 11:59:10 INFO - PROCESS | 12631 | Cycle 1(1): loaded http://localhost:57488/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57488/tests/dromaeo/cssquery-ext.html) 11:59:11 INFO - PROCESS | 12631 | RSS: Main: 250408960 11:59:11 INFO - PROCESS | 12631 | 12:02:14 INFO - PROCESS | 12631 | Cycle 1(1): loaded http://localhost:57488/tests/dromaeo/cssquery-ext.html (next: http://localhost:57488/tests/dromaeo/cssquery-jquery.html) 12:02:14 INFO - PROCESS | 12631 | RSS: Main: 275353600 12:02:14 INFO - PROCESS | 12631 | 12:05:17 INFO - PROCESS | 12631 | Cycle 1(1): loaded http://localhost:57488/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57488/tests/dromaeo/cssquery-mootools.html) 12:05:17 INFO - PROCESS | 12631 | RSS: Main: 218382336 12:05:17 INFO - PROCESS | 12631 | 12:08:20 INFO - PROCESS | 12631 | Cycle 1(1): loaded http://localhost:57488/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57488/tests/dromaeo/cssquery-prototype.html) 12:08:20 INFO - PROCESS | 12631 | RSS: Main: 217911296 12:08:20 INFO - PROCESS | 12631 | 12:11:24 INFO - PROCESS | 12631 | Cycle 1(1): loaded http://localhost:57488/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57488/tests/dromaeo/cssquery-yui.html) 12:11:24 INFO - PROCESS | 12631 | RSS: Main: 220004352 12:11:24 INFO - PROCESS | 12631 | 12:14:27 INFO - PROCESS | 12631 | Cycle 1(1): loaded http://localhost:57488/tests/dromaeo/cssquery-yui.html (next: http://localhost:57488/tests/dromaeo/cssquery-dojo.html) 12:14:28 INFO - PROCESS | 12631 | RSS: Main: 308625408 12:14:28 INFO - PROCESS | 12631 | 12:14:28 INFO - PROCESS | 12631 | __start_tp_report 12:14:28 INFO - PROCESS | 12631 | _x_x_mozilla_page_load 12:14:28 INFO - PROCESS | 12631 | _x_x_mozilla_page_load_details 12:14:28 INFO - PROCESS | 12631 | |i|pagename|runs| 12:14:28 INFO - PROCESS | 12631 | |0;dojo.html;2532.417543964888;2600.570905800543;2615.3853844346577;2622.973770262297;2647.2852329870925;4604.56256655618;4675.625949924007;4681.531846815316;4764.857054288377;4808.158572249859;4698.436187657478;4703.270992996083;4717.504662010482;4725.527447255273;4733.8343157989475;4330.090680957002;4358.0194456247245;4385.8245670173155;4407.427034485512;4418.248897687385;4373.781310934456;4393.582609652078;4408.096340250241;4410.75740834254;4412;4284.550122237167;4305.655547556188;4320.438343015419;4372.497162826284;4400.713953593006;4387.276099443604;4405.977970110161;4406.603405693471;4409.647228221735;4454.977725111354;4233.957660423387;4271.423357846682;4280.978595107004;4312.137572485484;4370.825166993316;4670.462896766881;4675.228587283094;4678.672492925497;4686.461056978457;4759;4968.627352948543;5020.698758074527;5031.773570189313;5032.748362581893;5071.670341427833;4929.038837426703;4984.526469985346;4991.301217829507;5061.569766569846;5121.487851214886;4695.483496815347;4705.6941298816155;4706.1293660672545;4735.573798358164;4742.976285118552;5140.717260550706;5153.3558305211845;5160.793568257228;5166.095933211748;5220.373555173328;4825.613950883921;4938.555530002317;4942.851714448572;4943.703377797344;4946.159152944008;5058.342415485963;5064.392272927273;5068.037072956126;5127.179651255856;5128.615353848401;4997.85006449807;5008.449070602231;5041.823536176216;5046.545810877039;5099.107656160231;4789.185838407479;4832.782524786393;5026.246063090565;5040.59675225981;5044.621653375938;4283.850065247701;4319.805608747614;4330.545292744279;4332.978335108367;4358.782060896942;3735.2529494101286;3739.7569158004644;3757.6993840492696;3787.5076240089165;3794.5446546414055;4210.221109094766;4361.3676016978;4368.453943257093;4371.409859668967;4420.9336859947125;4954.900901982012;5027.723475208825;5037.697738135724;5054.848354549369;5120.206368012964;4291.592298731615;4321.351797230378;4322.286822674224;4328.156009578102;4378.978105109454;4397.560243975641;4488.102379524108;4521.909561808811;4527.637788976874;4574.08518296342;4690.319903614025;4705.294205869147;4741.739204343794;4786.856394308176;4789.568938795525;5010.649254552146;5042.067217564616;5060.8987820242655;5062.670926389773;5121.74391280442;4732.929006064981;4734.4081989751285;4736.5973892219545;4742.051589682008;4796.544328288807;4858.198397264412;4911.140550403737;4942.1104201244125;4962.032403681247;5013.699178049329;5017.974910125426;5022.070916880389;5022.723750193774;5031.672941258953;5071.847844564669;4868.099401610713;4872.4153101628035;4879.34128892595;4880.780364883518;4929.309896614549;4743.66794324394;4790.880227994328;4795.20879054966;4830.6135509159885;4854.05345957549;4753.049390122059;4787.0904528139545;4834.613230941446;4855.271709243641;4912.263160525949;4794.736289504111;4959.628027897994;4960.156773348612;4977.552020318189;4978.626603004716;4699.060187962489;4769.379980602499;4788.521147885183;4833.081714474239;4845.830395936126 12:14:28 INFO - PROCESS | 12631 | |1;ext.html;554.3237250554323;560.3779804417096;575.7927146227357;578.3349148479251;580.2109131581049;34068;38324.04189895257;38407;38423.80788096056;38443;39186;39643.20713585734;39677.80161099198;39680;39692.20615587686;7676.232376762321;7835.333996610295;7839.333656639164;7843.33331666809;7843.921560784376;7697.0378702662165;7772;7781.8832717509285;7782.221777822229;7784.559856426579;7717.575533345664;7778.494397864149;7808.4924479908905;7818.609069546528;7819.6481158348015;7742.8838567421535;7792.376609871197;7796.376289896794;7798.961005194995;7799.493032952868;7692.923070769277;7730.574818384986;7758.534487930742;7761.8447631047065;7762.340201082915;36290.27419451623;36428.81785591081;36543.63456365429;36660.450093248626;36694.26611467783;2914.4316858212655;3010.473167195732;3053.923651908698;3180.3321302526497;3314.685104915029;27931.58102628462;28070;28286.292842679097;28406.573901391497;29869.850650746823;3181.363727254535;3196.7122958933805;3251.463508521091;3263.8041717497026;3291.8683252669866;229625;229626;229664;229753;229931;31074.53388199179;52094.47905520896;52634.473655263726;52790.47209527932;52803.73598131985;30596.847015765223;32104.518432223536;32279.838600806845;32291.838540807144;32402.83798581039;12699.746005079847;12841.935790321175;12851.742965140646;12859.357032148542;12866.549670761478;10255.897441025643;10383.065524102867;10392.584296628202;10394.376337419779;10401;7664.4634875559295;7697.884531732028;7748.535087894632;7756.138526753539;7761.4566980311965;2996.3707621399312;3002.6396832380256;3099.2406860319365;3117.516784898344;3139.952900706491;836.0176792269181;873.895132584094;900;938.3150300280834;946.753844000551;25728.228153155436;26219.21342359732;26923.596146057826;27030.729692703215;27116.1865144046;755.9092908850973;937.3438592984937;995.2635050062902;1003.668789299544;1020.285799940045;13360.19838809655;14189.85810141906;14362.768377115066;14459.710805783825;14732.410703571737;347174;352104;352166;352459;352612;49184.508154917996;49651;49728.28124765626;49795.50204497909;49967.50032499701;1045.6915210013065;1117.754094099313;1137.0392018744149;1179.9587014454453;1186.0748616079472;26037.6094358581;28697.42605147927;29035.41929161447;29469.26326841846;29655.555166672948;41184.38223426591;41485.37771933363;41575;41660.79169604133;41699.7915010423;287528;288466;289159;289501.7624559403;290138;23943;24726.13458528943;25625.359366016;25654.743452565235;26414.471710565296;41218.79390603028;41230.79384603058;41289.380659290735;42321.365179522945;42830.78584607057;35193.64806351904;35215.11962200965;35325.82337088298;35471.11322216862;35979.28041439104;34753.30493390169;34924;35195.296094077465;35357.646423535436;35394.64605353914;34784.82607586946;35257.471137932436;35432.114197145274;35610.28779424345;36110;30519.389612208077;33094.5035824458;33109.83445082759;33185.83407082949;33533.83233083819;24341.878290609144;24353.634695479228;25147.24558263255;25307.873460632578;25629 12:14:28 INFO - PROCESS | 12631 | |2;jquery.html;340.6474299100432;360.78352988207075;361.30989809463915;363.71993564954977;384.26221654423506;12465.68835779106;15917.363305467781;16154.676906461864;17321.133943302848;17425;14989.700205995901;15053.247337633102;15133.848661513382;15193;15272.083674979482;4968.180250258703;5074.31496747938;5195.896082078356;5204.141316682742;5337.412884582693;3384.1032126486502;5269.209618557228;5291.920621190685;5299.231611416342;5302.628815982883;6652.101966234545;6984.5809251444825;6988.650567471632;7005.579665220103;7147.3210045045635;6660.200775906874;6831.6242606656615;7010.544314619533;7067.363937245621;7072.611006394646;6316.842078948017;6815.182178138605;6819.352161544645;6822.658867056627;6828.829279268009;22583;22928.31215063551;23167.88416057926;23414.88292558526;23484.295471135894;1967.1639553189837;1970.4384250488686;1985.8808471491757;1995.2717258200798;2056.8251698605636;14121.78817317741;14228.14631122136;14694.338754756061;14727.705445891022;14946.775798363033;1844.9354272600394;1845.630873825227;1871.167330537911;1880.8495320374336;2027.6755719085022;62642.68678656623;79589;80889.59555202187;83059.58470207671;83409;15989.60025999336;16071.616008637004;16424.75362869558;16704.83295167057;17134;28587.428251434856;28781.712182878324;28818.567721484196;28841.711582884323;28914.27714307117;9088.727338179866;9354.625814967461;9359.953200233955;9643.373180743229;9695.6121755129;7673.309402153833;7677.347425468786;7728.961355193188;7906.604669766489;7953.085395179628;8410.663573456994;8445.915540844635;8522.403431759842;8589.28214357131;8596.183362580545;2997.8501074946166;3090.752739780812;3146.9527957080663;3333.3498825830693;3417.6753208445157;656.967151642416;706.2478460439615;715.4848509073458;717.8959050937585;753.600591686407;14317.928410357881;14663.706725865422;14874.479393221185;14907.180105094107;15421;729.5659082845698;732.5861485477649;732.8241222106656;755.7014979083232;766.5247546521081;7914.722984695508;8164.428490005643;8287.50274983503;8345.207205315486;8668.263197628146;355707;363711;369542.3045769508;370363;375393;76359;83791;84422.5778871114;85097.57451212828;88204;884.6328773558901;894.1326912894352;936.7002559180996;939.6429356844492;944.2398868910593;15399;15422.614434639223;16085.195740212708;16463.259153337887;16544.75182872234;34611.653883460844;36884.63115368812;39579;39764.40353394643;40780.79609601933;48231.758841206974;48357;52595.474045259056;53998;56931;7377.557346559223;7657.119431265253;7716.151223365313;7783.766487005399;7979.72070977513;11068.889311107108;11423.485943132746;11772.234804737665;11965.222260553037;12233.938830305791;10271.126954208976;10619.203559732896;10622.628208012682;10648.467576621293;10843.403612801372;9630.47032413224;10078.949605251926;10086.142677872169;10253.179745620184;10524.947375263075;10566.894331056592;10756.524022573354;10807.379488196662;10846.349219046882;10876.782464350827;7765.339946104645;7830.960845195737;7831.569263690551;7948.324392426708;7962.84074318522;9126.726198214064;10560.947195263974;10613.734656633645;10836.620718274822;10936.726581835517 12:14:28 INFO - PROCESS | 12631 | |3;mootools.html;1222.0468034932755;1340.6983428728538;1363.9590812275633;1430.3706369197553;1666.5916850371661;6620.172478440195;7010.7195712171515;7301.780946571598;7309.89035164473;7345.632718364081;6981.441484681226;7025.9297407025915;7029.718811247544;7218.278172182779;7240.927590724091;2136.903839327234;2188.5622875424897;2189.9343019709436;2195.7913998170147;2197.461621902636;2132.3070002249256;2155.7520885098256;2169.457635591102;2171.2400659769114;2189.343197040889;2131.818795402393;2136.2736669532355;2146.4526545730896;2154.246013895132;2181.0730439563204;2076.0346438905904;2088.2482306369693;2088.467440802593;2088.979110208909;2089.5507465894752;2066.5763518478675;2091.0799248330686;2107.093949601671;2114.0381126587367;2114.0698092839257;7188.317109874606;7393.8521229575645;7445.404367650575;7452.403807695371;7482.962585187093;4362.323839804835;4459.955400445986;4461.665375096881;4471.82112715491;4477.6417886569;2895.782816288766;2975.9404811903855;3023.9113918989146;3031.045220755455;3040.8783648654025;1004.62828753361;1007.1741172238767;1010.2574607663362;1020.8315627921384;1024.907758301749;10457.477126143662;10637.57449702011;10672;10720.892791072145;10750.838737418944;4003.939940900889;4215.683823713233;4236.703430759817;4238.046439551138;4270.380794784739;9213.585388657526;9247.815043699224;9251.491167985825;9257.814843703089;9268.768280793034;4635.23518619424;4649.883752906205;4654.953450465452;4655.767211639404;4668.39310889589;3605.9278814423565;3652.5069115669576;4176.310908700091;4182.623563879265;4252.55348188442;3548.929021419557;3564.928701425957;3655.670989610948;3669.119411341259;3671.320805650963;1157.438642258504;1181.2203945395997;1193.1290158184574;1194.9842633761234;1202.8436303280519;778.5990215039259;791.0349373763999;793.5238856686058;794.6940427935286;796.5897562755185;4753;4799.568038876448;4814.735189564538;4883.413990321184;5066.265391518283;376.7795839433907;379.7341860697523;384.5750445757454;393.8739603326965;394.4123256348021;3297.472404415282;3383.1034775784437;3408.4205685033603;3434.780652868246;3484.5121682964404;8745.475271483605;9438.669646562337;9476.573554190078;9497.620095196253;9535;9251.629934802668;9256.166944974984;9271.67549135777;9292.442453452815;9302.813943721088;6754.45964322853;7080.185778635419;7113.715451381887;7124.002639630456;7143;4892.3884514435695;4896;4950.480199578992;4955.900881982412;4998.4251811042195;8385;8525.95737021311;8778.824423511622;8782.429142105742;8840.115988401109;7815.921840781747;8074.071481779671;8571.57142142903;8604.698835540727;8607.526586037828;6053;6231.906521402273;6242.968785156045;6254.3745625437095;6261.96869015652;6773.864522709617;6788.355106264897;6801.795946121624;6835.863282734218;6891.207511136083;6123.173371594778;6183.907241391473;6212.844678882883;6275.435210831047;6437.871242575216;6003.369646187088;6022.427869352405;6062.757489700539;6087.482563982111;6091.725872335667;5461.453854614507;5515.696636685021;5519.613627046068;5669.858253543694;5848.2689663792025;4251.893702657459;4347.65218782503;4349.869503914888;4356.302991521341;4413.205622987893;4191.538930717679;4236.919585505676;4268.679849011274;4408.845690400821;4421.602055814992 12:14:28 INFO - PROCESS | 12631 | |4;prototype.html;287.2502767776104;287.7453453693481;292.8111368167532;293.90154298310074;294.3348033444415;4880.804767809288;4904.337914381557;4921.335619691341;4921.630877684174;4931.950680493194;4789.437650856792;4809.374781278438;4840;4853.733044682541;4865.391826021747;3590.1563132663805;3672.5592928848578;3780.4329350597354;3782.243551289739;3822.4648549203134;3776.3202623527754;3791.3128657747316;3801.5058042454443;3816.4275358696277;3821.6942644588366;3767.1523907120813;3787;3790.8862734117884;3797.468354430382;3800.410936304877;3576.964230357702;3647.434647629622;3755.962440375589;3783;3812.866549670748;3306.9173270668184;3319.883804066846;3319.9502007469905;3320.352531256406;3333.683300086512;4683.461401938786;4688.765561721901;4698.154332220199;4718.504557021498;4748.240281554935;4191.622753952129;4293.377460268275;4308.590683885026;4309.224339618867;4309.28896732042;4985.950140498621;5009.4239162496415;5012.548870601663;5023.32185155003;5038.420581633122;3608.6030536640947;3628.8548458061646;3630.818459077062;3636.4181730922924;3643.726720495947;5159.503743914261;5301.416844147102;5305.920411193835;5331.920021199685;5336.706481143536;3686.299603075407;3698.593154752975;3717.2565486902186;3724.385476396364;3735.6264373562426;3790.1851102012647;3791.639794219545;3792.469054332396;3799.4680744695765;3807.809609519513;4278.336857787048;4281.850135245251;4286.314189729628;4291.3777502262;4302.612764851178;4856;5009.824656137018;5010.949890501121;5082.949170508247;5088.77100530477;1283.671400100891;1296.935153242334;1301.284293638495;1302.1275745250705;1304.3673818198167;813.5647428625657;837.5844822250377;840.2353857989323;858.4591707224408;862.65062649627;4339.305711086211;4439.223135951195;4455.598996090367;4456.821727130943;4467.374567560544;5199.7140157291715;5217.217417387346;5219.712915789668;5232.964880369376;5253.527182553512;4458.7324760514475;4465.553444655508;4466.709663871838;4474.120869234929;4492.775361231926;2605.4137818990575;2752.9587056194173;2763.571646394812;2770.600846572468;2777.4583956128363;4881.291547958186;4905.852824415273;4911.656184067152;4928.950710492849;4932.28481870134;5221.156758850464;5277.967982326832;5337.572994160458;5392.299001129906;5394.62237643369;4806.423229212517;4829.285603610668;4852.80588776445;4877.292792545061;4916.606671466274;5181.637285389987;5192.9740351298005;5205.453427390221;5213.45258747826;5227.817026404057;4858.63560232991;5055.443901170795;5097.592192624656;5110.284560161506;5121.436641969306;4824.300476430968;4828.179209534458;4868.3427737255015;4882.267659851051;4903.632227583017;3357.630660627378;3380.7126394256766;3402.2988505747126;3412.948805767866;3417.4532074867902;4460.888477788081;4679.157751604744;4689.366935463669;4691.202495575692;4695.460022097366;4469.329600559812;4492.573205545468;4499.605122412063;4509.977450112729;4551.271796512542;4441.844535441373;4487.439070116236;4495.460544734653;4530.207213737649;4530.275155975029;4408.030233348658;4416.580424859633;4422.7346359218545;4428.756418397019;4483.574060464251;4571.748553829571;4692.741899195577;5034.748262586782;5071.290019397361;5096.847094587169;4922.581580565692;4930.630202734737;4934.901301974012;4944.184209605375;4945.307656928105 12:14:28 INFO - PROCESS | 12631 | |5;yui.html;577.9219805326281;602.3945934335992;639.7824739588539;675.9188897332318;729.4711334282642;12588.937055314722;13624.863751362509;13629.25039122848;13633.454661813528;13715.108517946339;12801.743965120715;12813.551525696603;12816.743665126693;12822.102452828305;12889.677758056054;600.2227115884939;721.462510429728;734.966926488308;746.3506749128265;748.8539734751726;741.6810771368309;742.8885667149917;743.1231147246248;745.2845268542179;748.962551872407;800.8478389106081;801.7274126796888;802.5345299726145;803.1326167738857;803.5018288661009;631.6589041917382;767.1484652036207;792.1642666986327;792.5522080024767;794.7655441644729;579.797071025142;580.7415700013496;581.1341101758392;581.2443823030086;581.2588949089902;11514.424278786028;11607.6517704469;11728.824067638992;11737.119716021247;11789.528418863321;11842.111841611913;12403.62789116328;12618.305993170372;12729.68895194895;13128.540501082416;10730.463476826206;10966.451677416097;11032.669019929415;11078.279911805706;11266.493007814586;3985.980070099631;4002.7198096133284;4048.736832105933;4176.540580536139;4197.958020419787;61568.69215653938;61882.0717689235;62534;62984.37015629831;63260;10307.690769276935;10342.844857327145;10390.48047597617;10484.26610137283;10515.52680129396;19508.90245548763;19529.218831246875;19545.511362216057;19580;19595.804041959684;6688.23734382002;6810.727570897207;6837.555558888656;7035.8241043973285;7112.608806515588;3513.402721537345;3531.611522732497;3596.928061438809;3609.9458508122398;3658.579263384745;2806.873690683924;2902.288939209865;2912.4466351393166;2914.3297041680107;2916.314666053476;488.9071076495454;523.0767695018296;536.1582315764291;544.056062731169;554.3707891543128;422.0753364657173;504.4199170953433;522.5885950977572;523.4529916237465;534.3614380814889;7054.188768291712;7116.430685545144;7170.282971702893;7388.741394051182;7567.621618919032;466.6733286699324;488.8289098815386;509.27428414509916;511.1310771688145;526.1741756106305;3443.913902152466;3517.191046059421;3553.9466907996402;3608;3732.3468393031653;58394.41605583975;89946.10053899378;98161.50919245358;105923.47038264759;106273.46863265634;87222;88997.55501222452;90852.54573727222;90984.54507727419;94452;44418;60736.69631651814;62920.37079629145;63197;69044;7414.147373051952;7602.657880395506;7699.690092971974;7839.9216007839195;8042.67829286822;40133;43092.56907431011;43676.781616091714;43888.561114388445;44436.55563444324;62094.68952655208;63462.365376345646;64435;64554.354456454836;66044.66977665082;8196.467229630294;8503.872441913252;8981.236594889508;9154.542272886461;9654.806903861743;9767;9924.1068303853;9985.400875947467;10128.34165779222;10375.066244038073;9352.812943741223;10500.684979450629;10755.978182072691;10853.240273181118;11600.883991160317;9951.104400603981;10433.26967112295;10653.307535010199;10695.358278503314;10743.731406714895;10128.34165779222;10130.645427410005;10244.282900196915;10400.167986561208;10864.076553493042;8832.072632373765;8888.73333799987;9266.21237194846;9291.303152263472;9326.906730932604;8970.237529809778;9048.781455902377;9491.620335186515;9613.471259080537;9747.171490423394 12:14:28 INFO - PROCESS | 12631 | __end_tp_report 12:14:28 INFO - PROCESS | 12631 | __start_cc_report 12:14:28 INFO - PROCESS | 12631 | _x_x_mozilla_cycle_collect,1443 12:14:28 INFO - PROCESS | 12631 | __end_cc_report 12:14:28 INFO - PROCESS | 12631 | __startTimestamp1472325268124__endTimestamp 12:14:28 INFO - PROCESS | 12631 | 12:14:28 INFO - PROCESS | 12631 | ------- Summary: start ------- 12:14:28 INFO - PROCESS | 12631 | Number of tests: 6 12:14:28 INFO - PROCESS | 12631 | 12:14:28 INFO - PROCESS | 12631 | [#0] dojo.html Cycles:165 Average:4652.42 Median:4759.00 stddev:482.12 (10.1%) stddev-sans-first:454.01 12:14:28 INFO - PROCESS | 12631 | Values: 2532.4 2600.6 2615.4 2623.0 2647.3 4604.6 4675.6 4681.5 4764.9 4808.2 4698.4 4703.3 4717.5 4725.5 4733.8 4330.1 4358.0 4385.8 4407.4 4418.2 4373.8 4393.6 4408.1 4410.8 4412.0 4284.6 4305.7 4320.4 4372.5 4400.7 4387.3 4406.0 4406.6 4409.6 4455.0 4234.0 4271.4 4281.0 4312.1 4370.8 4670.5 4675.2 4678.7 4686.5 4759.0 4968.6 5020.7 5031.8 5032.7 5071.7 4929.0 4984.5 4991.3 5061.6 5121.5 4695.5 4705.7 4706.1 4735.6 4743.0 5140.7 5153.4 5160.8 5166.1 5220.4 4825.6 4938.6 4942.9 4943.7 4946.2 5058.3 5064.4 5068.0 5127.2 5128.6 4997.9 5008.4 5041.8 5046.5 5099.1 4789.2 4832.8 5026.2 5040.6 5044.6 4283.9 4319.8 4330.5 4333.0 4358.8 3735.3 3739.8 3757.7 3787.5 3794.5 4210.2 4361.4 4368.5 4371.4 4420.9 4954.9 5027.7 5037.7 5054.8 5120.2 4291.6 4321.4 4322.3 4328.2 4379.0 4397.6 4488.1 4521.9 4527.6 4574.1 4690.3 4705.3 4741.7 4786.9 4789.6 5010.6 5042.1 5060.9 5062.7 5121.7 4732.9 4734.4 4736.6 4742.1 4796.5 4858.2 4911.1 4942.1 4962.0 5013.7 5018.0 5022.1 5022.7 5031.7 5071.8 4868.1 4872.4 4879.3 4880.8 4929.3 4743.7 4790.9 4795.2 4830.6 4854.1 4753.0 4787.1 4834.6 4855.3 4912.3 4794.7 4959.6 4960.2 4977.6 4978.6 4699.1 4769.4 4788.5 4833.1 4845.8 12:14:28 INFO - PROCESS | 12631 | 12:14:28 INFO - PROCESS | 12631 | [#1] ext.html Cycles:180 Average:43510.49 Median:193659.56 stddev:77404.58 (40.0%) stddev-sans-first:77554.53 12:14:28 INFO - PROCESS | 12631 | Values: 554.3 560.4 575.8 578.3 580.2 34068.0 38324.0 38407.0 38423.8 38443.0 39186.0 39643.2 39677.8 39680.0 39692.2 7676.2 7835.3 7839.3 7843.3 7843.9 7697.0 7772.0 7781.9 7782.2 7784.6 7717.6 7778.5 7808.5 7818.6 7819.6 7742.9 7792.4 7796.4 7799.0 7799.5 7692.9 7730.6 7758.5 7761.8 7762.3 36290.3 36428.8 36543.6 36660.5 36694.3 2914.4 3010.5 3053.9 3180.3 3314.7 27931.6 28070.0 28286.3 28406.6 29869.9 3181.4 3196.7 3251.5 3263.8 3291.9 229625.0 229626.0 229664.0 229753.0 229931.0 31074.5 52094.5 52634.5 52790.5 52803.7 30596.8 32104.5 32279.8 32291.8 32402.8 12699.7 12841.9 12851.7 12859.4 12866.5 10255.9 10383.1 10392.6 10394.4 10401.0 7664.5 7697.9 7748.5 7756.1 7761.5 2996.4 3002.6 3099.2 3117.5 3140.0 836.0 873.9 900.0 938.3 946.8 25728.2 26219.2 26923.6 27030.7 27116.2 755.9 937.3 995.3 1003.7 1020.3 13360.2 14189.9 14362.8 14459.7 14732.4 347174.0 352104.0 352166.0 352459.0 352612.0 49184.5 49651.0 49728.3 49795.5 49967.5 1045.7 1117.8 1137.0 1180.0 1186.1 26037.6 28697.4 29035.4 29469.3 29655.6 41184.4 41485.4 41575.0 41660.8 41699.8 287528.0 288466.0 289159.0 289501.8 290138.0 23943.0 24726.1 25625.4 25654.7 26414.5 41218.8 41230.8 41289.4 42321.4 42830.8 35193.6 35215.1 35325.8 35471.1 35979.3 34753.3 34924.0 35195.3 35357.6 35394.6 34784.8 35257.5 35432.1 35610.3 36110.0 30519.4 33094.5 33109.8 33185.8 33533.8 24341.9 24353.6 25147.2 25307.9 25629.0 12:14:28 INFO - PROCESS | 12631 | 12:14:28 INFO - PROCESS | 12631 | [#2] jquery.html Cycles:180 Average:25198.97 Median:19981.63 stddev:60988.84 (305.2%) stddev-sans-first:61131.37 12:14:28 INFO - PROCESS | 12631 | Values: 340.6 360.8 361.3 363.7 384.3 12465.7 15917.4 16154.7 17321.1 17425.0 14989.7 15053.2 15133.8 15193.0 15272.1 4968.2 5074.3 5195.9 5204.1 5337.4 3384.1 5269.2 5291.9 5299.2 5302.6 6652.1 6984.6 6988.7 7005.6 7147.3 6660.2 6831.6 7010.5 7067.4 7072.6 6316.8 6815.2 6819.4 6822.7 6828.8 22583.0 22928.3 23167.9 23414.9 23484.3 1967.2 1970.4 1985.9 1995.3 2056.8 14121.8 14228.1 14694.3 14727.7 14946.8 1844.9 1845.6 1871.2 1880.8 2027.7 62642.7 79589.0 80889.6 83059.6 83409.0 15989.6 16071.6 16424.8 16704.8 17134.0 28587.4 28781.7 28818.6 28841.7 28914.3 9088.7 9354.6 9360.0 9643.4 9695.6 7673.3 7677.3 7729.0 7906.6 7953.1 8410.7 8445.9 8522.4 8589.3 8596.2 2997.9 3090.8 3147.0 3333.3 3417.7 657.0 706.2 715.5 717.9 753.6 14317.9 14663.7 14874.5 14907.2 15421.0 729.6 732.6 732.8 755.7 766.5 7914.7 8164.4 8287.5 8345.2 8668.3 355707.0 363711.0 369542.3 370363.0 375393.0 76359.0 83791.0 84422.6 85097.6 88204.0 884.6 894.1 936.7 939.6 944.2 15399.0 15422.6 16085.2 16463.3 16544.8 34611.7 36884.6 39579.0 39764.4 40780.8 48231.8 48357.0 52595.5 53998.0 56931.0 7377.6 7657.1 7716.2 7783.8 7979.7 11068.9 11423.5 11772.2 11965.2 12233.9 10271.1 10619.2 10622.6 10648.5 10843.4 9630.5 10078.9 10086.1 10253.2 10524.9 10566.9 10756.5 10807.4 10846.3 10876.8 7765.3 7831.0 7831.6 7948.3 7962.8 9126.7 10560.9 10613.7 10836.6 10936.7 12:14:28 INFO - PROCESS | 12631 | 12:14:28 INFO - PROCESS | 12631 | [#3] mootools.html Cycles:180 Average:4896.82 Median:4642.56 stddev:2762.79 (59.5%) stddev-sans-first:2756.74 12:14:28 INFO - PROCESS | 12631 | Values: 1222.0 1340.7 1364.0 1430.4 1666.6 6620.2 7010.7 7301.8 7309.9 7345.6 6981.4 7025.9 7029.7 7218.3 7240.9 2136.9 2188.6 2189.9 2195.8 2197.5 2132.3 2155.8 2169.5 2171.2 2189.3 2131.8 2136.3 2146.5 2154.2 2181.1 2076.0 2088.2 2088.5 2089.0 2089.6 2066.6 2091.1 2107.1 2114.0 2114.1 7188.3 7393.9 7445.4 7452.4 7483.0 4362.3 4460.0 4461.7 4471.8 4477.6 2895.8 2975.9 3023.9 3031.0 3040.9 1004.6 1007.2 1010.3 1020.8 1024.9 10457.5 10637.6 10672.0 10720.9 10750.8 4003.9 4215.7 4236.7 4238.0 4270.4 9213.6 9247.8 9251.5 9257.8 9268.8 4635.2 4649.9 4655.0 4655.8 4668.4 3605.9 3652.5 4176.3 4182.6 4252.6 3548.9 3564.9 3655.7 3669.1 3671.3 1157.4 1181.2 1193.1 1195.0 1202.8 778.6 791.0 793.5 794.7 796.6 4753.0 4799.6 4814.7 4883.4 5066.3 376.8 379.7 384.6 393.9 394.4 3297.5 3383.1 3408.4 3434.8 3484.5 8745.5 9438.7 9476.6 9497.6 9535.0 9251.6 9256.2 9271.7 9292.4 9302.8 6754.5 7080.2 7113.7 7124.0 7143.0 4892.4 4896.0 4950.5 4955.9 4998.4 8385.0 8526.0 8778.8 8782.4 8840.1 7815.9 8074.1 8571.6 8604.7 8607.5 6053.0 6231.9 6243.0 6254.4 6262.0 6773.9 6788.4 6801.8 6835.9 6891.2 6123.2 6183.9 6212.8 6275.4 6437.9 6003.4 6022.4 6062.8 6087.5 6091.7 5461.5 5515.7 5519.6 5669.9 5848.3 4251.9 4347.7 4349.9 4356.3 4413.2 4191.5 4236.9 4268.7 4408.8 4421.6 12:14:28 INFO - PROCESS | 12631 | 12:14:28 INFO - PROCESS | 12631 | [#4] prototype.html Cycles:180 Average:4128.51 Median:4497.53 stddev:1189.64 (26.5%) stddev-sans-first:1157.51 12:14:28 INFO - PROCESS | 12631 | Values: 287.3 287.7 292.8 293.9 294.3 4880.8 4904.3 4921.3 4921.6 4932.0 4789.4 4809.4 4840.0 4853.7 4865.4 3590.2 3672.6 3780.4 3782.2 3822.5 3776.3 3791.3 3801.5 3816.4 3821.7 3767.2 3787.0 3790.9 3797.5 3800.4 3577.0 3647.4 3756.0 3783.0 3812.9 3306.9 3319.9 3320.0 3320.4 3333.7 4683.5 4688.8 4698.2 4718.5 4748.2 4191.6 4293.4 4308.6 4309.2 4309.3 4986.0 5009.4 5012.5 5023.3 5038.4 3608.6 3628.9 3630.8 3636.4 3643.7 5159.5 5301.4 5305.9 5331.9 5336.7 3686.3 3698.6 3717.3 3724.4 3735.6 3790.2 3791.6 3792.5 3799.5 3807.8 4278.3 4281.9 4286.3 4291.4 4302.6 4856.0 5009.8 5010.9 5082.9 5088.8 1283.7 1296.9 1301.3 1302.1 1304.4 813.6 837.6 840.2 858.5 862.7 4339.3 4439.2 4455.6 4456.8 4467.4 5199.7 5217.2 5219.7 5233.0 5253.5 4458.7 4465.6 4466.7 4474.1 4492.8 2605.4 2753.0 2763.6 2770.6 2777.5 4881.3 4905.9 4911.7 4929.0 4932.3 5221.2 5278.0 5337.6 5392.3 5394.6 4806.4 4829.3 4852.8 4877.3 4916.6 5181.6 5193.0 5205.5 5213.5 5227.8 4858.6 5055.4 5097.6 5110.3 5121.4 4824.3 4828.2 4868.3 4882.3 4903.6 3357.6 3380.7 3402.3 3412.9 3417.5 4460.9 4679.2 4689.4 4691.2 4695.5 4469.3 4492.6 4499.6 4510.0 4551.3 4441.8 4487.4 4495.5 4530.2 4530.3 4408.0 4416.6 4422.7 4428.8 4483.6 4571.7 4692.7 5034.7 5071.3 5096.8 4922.6 4930.6 4934.9 4944.2 4945.3 12:14:28 INFO - PROCESS | 12631 | 12:14:28 INFO - PROCESS | 12631 | [#5] yui.html Cycles:180 Average:17056.65 Median:540.11 stddev:24871.10 (4604.8%) stddev-sans-first:24910.09 12:14:28 INFO - PROCESS | 12631 | Values: 577.9 602.4 639.8 675.9 729.5 12588.9 13624.9 13629.3 13633.5 13715.1 12801.7 12813.6 12816.7 12822.1 12889.7 600.2 721.5 735.0 746.4 748.9 741.7 742.9 743.1 745.3 749.0 800.8 801.7 802.5 803.1 803.5 631.7 767.1 792.2 792.6 794.8 579.8 580.7 581.1 581.2 581.3 11514.4 11607.7 11728.8 11737.1 11789.5 11842.1 12403.6 12618.3 12729.7 13128.5 10730.5 10966.5 11032.7 11078.3 11266.5 3986.0 4002.7 4048.7 4176.5 4198.0 61568.7 61882.1 62534.0 62984.4 63260.0 10307.7 10342.8 10390.5 10484.3 10515.5 19508.9 19529.2 19545.5 19580.0 19595.8 6688.2 6810.7 6837.6 7035.8 7112.6 3513.4 3531.6 3596.9 3609.9 3658.6 2806.9 2902.3 2912.4 2914.3 2916.3 488.9 523.1 536.2 544.1 554.4 422.1 504.4 522.6 523.5 534.4 7054.2 7116.4 7170.3 7388.7 7567.6 466.7 488.8 509.3 511.1 526.2 3443.9 3517.2 3553.9 3608.0 3732.3 58394.4 89946.1 98161.5 105923.5 106273.5 87222.0 88997.6 90852.5 90984.5 94452.0 44418.0 60736.7 62920.4 63197.0 69044.0 7414.1 7602.7 7699.7 7839.9 8042.7 40133.0 43092.6 43676.8 43888.6 44436.6 62094.7 63462.4 64435.0 64554.4 66044.7 8196.5 8503.9 8981.2 9154.5 9654.8 9767.0 9924.1 9985.4 10128.3 10375.1 9352.8 10500.7 10756.0 10853.2 11600.9 9951.1 10433.3 10653.3 10695.4 10743.7 10128.3 10130.6 10244.3 10400.2 10864.1 8832.1 8888.7 9266.2 9291.3 9326.9 8970.2 9048.8 9491.6 9613.5 9747.2 12:14:28 INFO - PROCESS | 12631 | -------- Summary: end -------- 12:14:28 INFO - PROCESS | 12631 | 12:14:29 INFO - TEST-INFO | 12631: exit 0 12:14:29 INFO - TEST-OK | dromaeo_css | took 1121430ms 12:14:29 INFO - TEST-START | kraken 12:14:29 INFO - operating with platform_type : linux_ 12:14:29 INFO - Initialising browser for kraken test... 12:14:29 INFO - TEST-INFO | started process 12936 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9PGIiH/profile http://localhost:57488/getInfo.html) 12:14:33 INFO - PROCESS | 12936 | __metrics Screen width/height:1600/1200 12:14:33 INFO - PROCESS | 12936 | colorDepth:24 12:14:33 INFO - PROCESS | 12936 | Browser inner width/height: 1024/697 12:14:33 INFO - PROCESS | 12936 | __metrics 12:14:33 INFO - PROCESS | 12936 | 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" 12:14:33 INFO - PROCESS | 12936 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:14:34 INFO - PROCESS | 12936 | console.error: PushService: 12:14:34 INFO - PROCESS | 12936 | stateChangeProcessEnqueue: Error transitioning state 12:14:34 INFO - PROCESS | 12936 | UnknownError 12:14:35 INFO - TEST-INFO | 12936: exit 0 12:14:35 INFO - Browser initialized. 12:14:35 INFO - Running cycle 1/1 for kraken test... 12:14:35 INFO - TEST-INFO | started process 13016 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9PGIiH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:14:47 INFO - PROCESS | 13016 | RSS: Main: 182349824 12:14:47 INFO - PROCESS | 13016 | 12:14:50 INFO - PROCESS | 13016 | Cycle 1(1): loaded http://localhost:57488/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57488/tests/kraken/driver.html?testName=audio-beat-detection) 12:14:51 INFO - PROCESS | 13016 | RSS: Main: 235839488 12:14:51 INFO - PROCESS | 13016 | 12:14:53 INFO - PROCESS | 13016 | Cycle 1(1): loaded http://localhost:57488/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57488/tests/kraken/driver.html?testName=audio-dft) 12:14:54 INFO - PROCESS | 13016 | RSS: Main: 225808384 12:14:54 INFO - PROCESS | 13016 | 12:14:57 INFO - PROCESS | 13016 | Cycle 1(1): loaded http://localhost:57488/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57488/tests/kraken/driver.html?testName=audio-fft) 12:14:58 INFO - PROCESS | 13016 | RSS: Main: 305287168 12:14:58 INFO - PROCESS | 13016 | 12:15:00 INFO - PROCESS | 13016 | Cycle 1(1): loaded http://localhost:57488/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57488/tests/kraken/driver.html?testName=audio-oscillator) 12:15:00 INFO - PROCESS | 13016 | RSS: Main: 214892544 12:15:01 INFO - PROCESS | 13016 | 12:15:03 INFO - PROCESS | 13016 | Cycle 1(1): loaded http://localhost:57488/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57488/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:15:03 INFO - PROCESS | 13016 | RSS: Main: 216625152 12:15:03 INFO - PROCESS | 13016 | 12:15:06 INFO - PROCESS | 13016 | Cycle 1(1): loaded http://localhost:57488/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57488/tests/kraken/driver.html?testName=imaging-darkroom) 12:15:07 INFO - PROCESS | 13016 | RSS: Main: 256012288 12:15:07 INFO - PROCESS | 13016 | 12:15:11 INFO - PROCESS | 13016 | Cycle 1(1): loaded http://localhost:57488/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57488/tests/kraken/driver.html?testName=imaging-desaturate) 12:15:11 INFO - PROCESS | 13016 | RSS: Main: 255418368 12:15:11 INFO - PROCESS | 13016 | 12:15:14 INFO - PROCESS | 13016 | Cycle 1(1): loaded http://localhost:57488/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57488/tests/kraken/driver.html?testName=json-parse-financial) 12:15:15 INFO - PROCESS | 13016 | RSS: Main: 254574592 12:15:15 INFO - PROCESS | 13016 | 12:15:16 INFO - PROCESS | 13016 | Cycle 1(1): loaded http://localhost:57488/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57488/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:15:17 INFO - PROCESS | 13016 | RSS: Main: 217591808 12:15:17 INFO - PROCESS | 13016 | 12:15:19 INFO - PROCESS | 13016 | Cycle 1(1): loaded http://localhost:57488/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57488/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:15:20 INFO - PROCESS | 13016 | RSS: Main: 224833536 12:15:20 INFO - PROCESS | 13016 | 12:15:22 INFO - PROCESS | 13016 | Cycle 1(1): loaded http://localhost:57488/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57488/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:15:22 INFO - PROCESS | 13016 | RSS: Main: 223444992 12:15:22 INFO - PROCESS | 13016 | 12:15:25 INFO - PROCESS | 13016 | Cycle 1(1): loaded http://localhost:57488/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57488/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:15:26 INFO - PROCESS | 13016 | RSS: Main: 224075776 12:15:26 INFO - PROCESS | 13016 | 12:15:29 INFO - PROCESS | 13016 | Cycle 1(1): loaded http://localhost:57488/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57488/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:15:29 INFO - PROCESS | 13016 | RSS: Main: 222277632 12:15:29 INFO - PROCESS | 13016 | 12:15:31 INFO - PROCESS | 13016 | Cycle 1(1): loaded http://localhost:57488/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57488/tests/kraken/driver.html?testName=ai-astar) 12:15:31 INFO - PROCESS | 13016 | RSS: Main: 272953344 12:15:31 INFO - PROCESS | 13016 | 12:15:31 INFO - PROCESS | 13016 | __start_tp_report 12:15:31 INFO - PROCESS | 13016 | _x_x_mozilla_page_load 12:15:31 INFO - PROCESS | 13016 | _x_x_mozilla_page_load_details 12:15:31 INFO - PROCESS | 13016 | |i|pagename|runs| 12:15:31 INFO - PROCESS | 13016 | |0;ai-astar;115;118;136;117;116;115;117;115;115;116 12:15:31 INFO - PROCESS | 13016 | |1;audio-beat-detection;158;122;146;181;122;148;148;124;175;134 12:15:31 INFO - PROCESS | 13016 | |2;audio-dft;161;160;159;160;160;161;162;162;160;160 12:15:31 INFO - PROCESS | 13016 | |3;audio-fft;77;77;75;166;76;76;77;76;158;76 12:15:31 INFO - PROCESS | 13016 | |4;audio-oscillator;83;83;144;83;83;83;137;83;84;145 12:15:31 INFO - PROCESS | 13016 | |5;imaging-gaussian-blur;117;117;117;117;117;117;116;116;118;116 12:15:31 INFO - PROCESS | 13016 | |6;imaging-darkroom;146;146;146;147;146;146;146;146;146;146 12:15:31 INFO - PROCESS | 13016 | |7;imaging-desaturate;95;96;95;95;95;94;95;95;95;95 12:15:31 INFO - PROCESS | 13016 | |8;json-parse-financial;65;64;70;63;63;65;65;65;63;63 12:15:31 INFO - PROCESS | 13016 | |9;json-stringify-tinderbox;65;65;65;64;65;65;65;65;65;66 12:15:31 INFO - PROCESS | 13016 | |10;stanford-crypto-aes;83;83;83;84;82;81;82;81;81;87 12:15:31 INFO - PROCESS | 13016 | |11;stanford-crypto-ccm;144;144;136;133;131;133;130;133;171;133 12:15:31 INFO - PROCESS | 13016 | |12;stanford-crypto-pbkdf2;173;175;174;175;170;170;170;172;170;173 12:15:31 INFO - PROCESS | 13016 | |13;stanford-crypto-sha256-iterative;68;69;74;68;68;68;68;68;69;68 12:15:31 INFO - PROCESS | 13016 | __end_tp_report 12:15:31 INFO - PROCESS | 13016 | __start_cc_report 12:15:31 INFO - PROCESS | 13016 | _x_x_mozilla_cycle_collect,2001 12:15:31 INFO - PROCESS | 13016 | __end_cc_report 12:15:31 INFO - PROCESS | 13016 | __startTimestamp1472325331947__endTimestamp 12:15:31 INFO - PROCESS | 13016 | 12:15:31 INFO - PROCESS | 13016 | ------- Summary: start ------- 12:15:31 INFO - PROCESS | 13016 | Number of tests: 14 12:15:31 INFO - PROCESS | 13016 | 12:15:31 INFO - PROCESS | 13016 | [#0] ai-astar Cycles:10 Average:118.00 Median:116.50 stddev:6.41 (5.5%) stddev-sans-first:6.71 12:15:31 INFO - PROCESS | 13016 | Values: 115.0 118.0 136.0 117.0 116.0 115.0 117.0 115.0 115.0 116.0 12:15:31 INFO - PROCESS | 13016 | 12:15:31 INFO - PROCESS | 13016 | [#1] audio-beat-detection Cycles:10 Average:145.80 Median:148.00 stddev:21.08 (14.2%) stddev-sans-first:21.89 12:15:31 INFO - PROCESS | 13016 | Values: 158.0 122.0 146.0 181.0 122.0 148.0 148.0 124.0 175.0 134.0 12:15:31 INFO - PROCESS | 13016 | 12:15:31 INFO - PROCESS | 13016 | [#2] audio-dft Cycles:10 Average:160.50 Median:160.50 stddev:0.97 (0.6%) stddev-sans-first:1.01 12:15:31 INFO - PROCESS | 13016 | Values: 161.0 160.0 159.0 160.0 160.0 161.0 162.0 162.0 160.0 160.0 12:15:31 INFO - PROCESS | 13016 | 12:15:31 INFO - PROCESS | 13016 | [#3] audio-fft Cycles:10 Average:93.40 Median:76.00 stddev:36.21 (47.6%) stddev-sans-first:37.92 12:15:31 INFO - PROCESS | 13016 | Values: 77.0 77.0 75.0 166.0 76.0 76.0 77.0 76.0 158.0 76.0 12:15:31 INFO - PROCESS | 13016 | 12:15:31 INFO - PROCESS | 13016 | [#4] audio-oscillator Cycles:10 Average:100.80 Median:83.00 stddev:28.51 (34.3%) stddev-sans-first:29.50 12:15:31 INFO - PROCESS | 13016 | Values: 83.0 83.0 144.0 83.0 83.0 83.0 137.0 83.0 84.0 145.0 12:15:31 INFO - PROCESS | 13016 | 12:15:31 INFO - PROCESS | 13016 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 12:15:31 INFO - PROCESS | 13016 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 116.0 116.0 118.0 116.0 12:15:31 INFO - PROCESS | 13016 | 12:15:31 INFO - PROCESS | 13016 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 12:15:31 INFO - PROCESS | 13016 | Values: 146.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 146.0 12:15:31 INFO - PROCESS | 13016 | 12:15:31 INFO - PROCESS | 13016 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 12:15:31 INFO - PROCESS | 13016 | Values: 95.0 96.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 12:15:31 INFO - PROCESS | 13016 | 12:15:31 INFO - PROCESS | 13016 | [#8] json-parse-financial Cycles:10 Average:64.60 Median:65.00 stddev:2.12 (3.3%) stddev-sans-first:2.24 12:15:31 INFO - PROCESS | 13016 | Values: 65.0 64.0 70.0 63.0 63.0 65.0 65.0 65.0 63.0 63.0 12:15:31 INFO - PROCESS | 13016 | 12:15:31 INFO - PROCESS | 13016 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:0.47 (0.7%) stddev-sans-first:0.50 12:15:31 INFO - PROCESS | 13016 | Values: 65.0 65.0 65.0 64.0 65.0 65.0 65.0 65.0 65.0 66.0 12:15:31 INFO - PROCESS | 13016 | 12:15:31 INFO - PROCESS | 13016 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:83.00 stddev:1.83 (2.2%) stddev-sans-first:1.94 12:15:31 INFO - PROCESS | 13016 | Values: 83.0 83.0 83.0 84.0 82.0 81.0 82.0 81.0 81.0 87.0 12:15:31 INFO - PROCESS | 13016 | 12:15:31 INFO - PROCESS | 13016 | [#11] stanford-crypto-ccm Cycles:10 Average:138.80 Median:134.50 stddev:12.35 (9.2%) stddev-sans-first:12.95 12:15:31 INFO - PROCESS | 13016 | Values: 144.0 144.0 136.0 133.0 131.0 133.0 130.0 133.0 171.0 133.0 12:15:31 INFO - PROCESS | 13016 | 12:15:31 INFO - PROCESS | 13016 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.20 Median:173.00 stddev:2.10 (1.2%) stddev-sans-first:2.20 12:15:31 INFO - PROCESS | 13016 | Values: 173.0 175.0 174.0 175.0 170.0 170.0 170.0 172.0 170.0 173.0 12:15:31 INFO - PROCESS | 13016 | 12:15:31 INFO - PROCESS | 13016 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:68.00 stddev:1.87 (2.8%) stddev-sans-first:1.96 12:15:31 INFO - PROCESS | 13016 | Values: 68.0 69.0 74.0 68.0 68.0 68.0 68.0 68.0 69.0 68.0 12:15:31 INFO - PROCESS | 13016 | -------- Summary: end -------- 12:15:31 INFO - PROCESS | 13016 | 12:15:33 INFO - TEST-INFO | 13016: exit 0 12:15:33 INFO - TEST-OK | kraken | took 64051ms 12:15:33 INFO - SUITE-END | took 1185s 12:15:33 INFO - Completed test suite (00:19:45) 12:15:33 INFO - javascript benchmark 12:15:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2532.417543964888, 2600.570905800543, 2615.3853844346577, 2622.973770262297, 2647.2852329870925, 4604.56256655618, 4675.625949924007, 4681.531846815316, 4764.857054288377, 4808.158572249859, 4698.436187657478, 4703.270992996083, 4717.504662010482, 4725.527447255273, 4733.8343157989475, 4330.090680957002, 4358.0194456247245, 4385.8245670173155, 4407.427034485512, 4418.248897687385, 4373.781310934456, 4393.582609652078, 4408.096340250241, 4410.75740834254, 4412.0, 4284.550122237167, 4305.655547556188, 4320.438343015419, 4372.497162826284, 4400.713953593006, 4387.276099443604, 4405.977970110161, 4406.603405693471, 4409.647228221735, 4454.977725111354, 4233.957660423387, 4271.423357846682, 4280.978595107004, 4312.137572485484, 4370.825166993316, 4670.462896766881, 4675.228587283094, 4678.672492925497, 4686.461056978457, 4759.0, 4968.627352948543, 5020.698758074527, 5031.773570189313, 5032.748362581893, 5071.670341427833, 4929.038837426703, 4984.526469985346, 4991.301217829507, 5061.569766569846, 5121.487851214886, 4695.483496815347, 4705.6941298816155, 4706.1293660672545, 4735.573798358164, 4742.976285118552, 5140.717260550706, 5153.3558305211845, 5160.793568257228, 5166.095933211748, 5220.373555173328, 4825.613950883921, 4938.555530002317, 4942.851714448572, 4943.703377797344, 4946.159152944008, 5058.342415485963, 5064.392272927273, 5068.037072956126, 5127.179651255856, 5128.615353848401, 4997.85006449807, 5008.449070602231, 5041.823536176216, 5046.545810877039, 5099.107656160231, 4789.185838407479, 4832.782524786393, 5026.246063090565, 5040.59675225981, 5044.621653375938, 4283.850065247701, 4319.805608747614, 4330.545292744279, 4332.978335108367, 4358.782060896942, 3735.2529494101286, 3739.7569158004644, 3757.6993840492696, 3787.5076240089165, 3794.5446546414055, 4210.221109094766, 4361.3676016978, 4368.453943257093, 4371.409859668967, 4420.9336859947125, 4954.900901982012, 5027.723475208825, 5037.697738135724, 5054.848354549369, 5120.206368012964, 4291.592298731615, 4321.351797230378, 4322.286822674224, 4328.156009578102, 4378.978105109454, 4397.560243975641, 4488.102379524108, 4521.909561808811, 4527.637788976874, 4574.08518296342, 4690.319903614025, 4705.294205869147, 4741.739204343794, 4786.856394308176, 4789.568938795525, 5010.649254552146, 5042.067217564616, 5060.8987820242655, 5062.670926389773, 5121.74391280442, 4732.929006064981, 4734.4081989751285, 4736.5973892219545, 4742.051589682008, 4796.544328288807, 4858.198397264412, 4911.140550403737, 4942.1104201244125, 4962.032403681247, 5013.699178049329, 5017.974910125426, 5022.070916880389, 5022.723750193774, 5031.672941258953, 5071.847844564669, 4868.099401610713, 4872.4153101628035, 4879.34128892595, 4880.780364883518, 4929.309896614549, 4743.66794324394, 4790.880227994328, 4795.20879054966, 4830.6135509159885, 4854.05345957549, 4753.049390122059, 4787.0904528139545, 4834.613230941446, 4855.271709243641, 4912.263160525949, 4794.736289504111, 4959.628027897994, 4960.156773348612, 4977.552020318189, 4978.626603004716, 4699.060187962489, 4769.379980602499, 4788.521147885183, 4833.081714474239, 4845.830395936126], "value": 4621.649938934584, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.3237250554323, 560.3779804417096, 575.7927146227357, 578.3349148479251, 580.2109131581049, 34068.0, 38324.04189895257, 38407.0, 38423.80788096056, 38443.0, 39186.0, 39643.20713585734, 39677.80161099198, 39680.0, 39692.20615587686, 7676.232376762321, 7835.333996610295, 7839.333656639164, 7843.33331666809, 7843.921560784376, 7697.0378702662165, 7772.0, 7781.8832717509285, 7782.221777822229, 7784.559856426579, 7717.575533345664, 7778.494397864149, 7808.4924479908905, 7818.609069546528, 7819.6481158348015, 7742.8838567421535, 7792.376609871197, 7796.376289896794, 7798.961005194995, 7799.493032952868, 7692.923070769277, 7730.574818384986, 7758.534487930742, 7761.8447631047065, 7762.340201082915, 36290.27419451623, 36428.81785591081, 36543.63456365429, 36660.450093248626, 36694.26611467783, 2914.4316858212655, 3010.473167195732, 3053.923651908698, 3180.3321302526497, 3314.685104915029, 27931.58102628462, 28070.0, 28286.292842679097, 28406.573901391497, 29869.850650746823, 3181.363727254535, 3196.7122958933805, 3251.463508521091, 3263.8041717497026, 3291.8683252669866, 229625.0, 229626.0, 229664.0, 229753.0, 229931.0, 31074.53388199179, 52094.47905520896, 52634.473655263726, 52790.47209527932, 52803.73598131985, 30596.847015765223, 32104.518432223536, 32279.838600806845, 32291.838540807144, 32402.83798581039, 12699.746005079847, 12841.935790321175, 12851.742965140646, 12859.357032148542, 12866.549670761478, 10255.897441025643, 10383.065524102867, 10392.584296628202, 10394.376337419779, 10401.0, 7664.4634875559295, 7697.884531732028, 7748.535087894632, 7756.138526753539, 7761.4566980311965, 2996.3707621399312, 3002.6396832380256, 3099.2406860319365, 3117.516784898344, 3139.952900706491, 836.0176792269181, 873.895132584094, 900.0, 938.3150300280834, 946.753844000551, 25728.228153155436, 26219.21342359732, 26923.596146057826, 27030.729692703215, 27116.1865144046, 755.9092908850973, 937.3438592984937, 995.2635050062902, 1003.668789299544, 1020.285799940045, 13360.19838809655, 14189.85810141906, 14362.768377115066, 14459.710805783825, 14732.410703571737, 347174.0, 352104.0, 352166.0, 352459.0, 352612.0, 49184.508154917996, 49651.0, 49728.28124765626, 49795.50204497909, 49967.50032499701, 1045.6915210013065, 1117.754094099313, 1137.0392018744149, 1179.9587014454453, 1186.0748616079472, 26037.6094358581, 28697.42605147927, 29035.41929161447, 29469.26326841846, 29655.555166672948, 41184.38223426591, 41485.37771933363, 41575.0, 41660.79169604133, 41699.7915010423, 287528.0, 288466.0, 289159.0, 289501.7624559403, 290138.0, 23943.0, 24726.13458528943, 25625.359366016, 25654.743452565235, 26414.471710565296, 41218.79390603028, 41230.79384603058, 41289.380659290735, 42321.365179522945, 42830.78584607057, 35193.64806351904, 35215.11962200965, 35325.82337088298, 35471.11322216862, 35979.28041439104, 34753.30493390169, 34924.0, 35195.296094077465, 35357.646423535436, 35394.64605353914, 34784.82607586946, 35257.471137932436, 35432.114197145274, 35610.28779424345, 36110.0, 30519.389612208077, 33094.5035824458, 33109.83445082759, 33185.83407082949, 33533.83233083819, 24341.878290609144, 24353.634695479228, 25147.24558263255, 25307.873460632578, 25629.0], "value": 16019.394111912341, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.6474299100432, 360.78352988207075, 361.30989809463915, 363.71993564954977, 384.26221654423506, 12465.68835779106, 15917.363305467781, 16154.676906461864, 17321.133943302848, 17425.0, 14989.700205995901, 15053.247337633102, 15133.848661513382, 15193.0, 15272.083674979482, 4968.180250258703, 5074.31496747938, 5195.896082078356, 5204.141316682742, 5337.412884582693, 3384.1032126486502, 5269.209618557228, 5291.920621190685, 5299.231611416342, 5302.628815982883, 6652.101966234545, 6984.5809251444825, 6988.650567471632, 7005.579665220103, 7147.3210045045635, 6660.200775906874, 6831.6242606656615, 7010.544314619533, 7067.363937245621, 7072.611006394646, 6316.842078948017, 6815.182178138605, 6819.352161544645, 6822.658867056627, 6828.829279268009, 22583.0, 22928.31215063551, 23167.88416057926, 23414.88292558526, 23484.295471135894, 1967.1639553189837, 1970.4384250488686, 1985.8808471491757, 1995.2717258200798, 2056.8251698605636, 14121.78817317741, 14228.14631122136, 14694.338754756061, 14727.705445891022, 14946.775798363033, 1844.9354272600394, 1845.630873825227, 1871.167330537911, 1880.8495320374336, 2027.6755719085022, 62642.68678656623, 79589.0, 80889.59555202187, 83059.58470207671, 83409.0, 15989.60025999336, 16071.616008637004, 16424.75362869558, 16704.83295167057, 17134.0, 28587.428251434856, 28781.712182878324, 28818.567721484196, 28841.711582884323, 28914.27714307117, 9088.727338179866, 9354.625814967461, 9359.953200233955, 9643.373180743229, 9695.6121755129, 7673.309402153833, 7677.347425468786, 7728.961355193188, 7906.604669766489, 7953.085395179628, 8410.663573456994, 8445.915540844635, 8522.403431759842, 8589.28214357131, 8596.183362580545, 2997.8501074946166, 3090.752739780812, 3146.9527957080663, 3333.3498825830693, 3417.6753208445157, 656.967151642416, 706.2478460439615, 715.4848509073458, 717.8959050937585, 753.600591686407, 14317.928410357881, 14663.706725865422, 14874.479393221185, 14907.180105094107, 15421.0, 729.5659082845698, 732.5861485477649, 732.8241222106656, 755.7014979083232, 766.5247546521081, 7914.722984695508, 8164.428490005643, 8287.50274983503, 8345.207205315486, 8668.263197628146, 355707.0, 363711.0, 369542.3045769508, 370363.0, 375393.0, 76359.0, 83791.0, 84422.5778871114, 85097.57451212828, 88204.0, 884.6328773558901, 894.1326912894352, 936.7002559180996, 939.6429356844492, 944.2398868910593, 15399.0, 15422.614434639223, 16085.195740212708, 16463.259153337887, 16544.75182872234, 34611.653883460844, 36884.63115368812, 39579.0, 39764.40353394643, 40780.79609601933, 48231.758841206974, 48357.0, 52595.474045259056, 53998.0, 56931.0, 7377.557346559223, 7657.119431265253, 7716.151223365313, 7783.766487005399, 7979.72070977513, 11068.889311107108, 11423.485943132746, 11772.234804737665, 11965.222260553037, 12233.938830305791, 10271.126954208976, 10619.203559732896, 10622.628208012682, 10648.467576621293, 10843.403612801372, 9630.47032413224, 10078.949605251926, 10086.142677872169, 10253.179745620184, 10524.947375263075, 10566.894331056592, 10756.524022573354, 10807.379488196662, 10846.349219046882, 10876.782464350827, 7765.339946104645, 7830.960845195737, 7831.569263690551, 7948.324392426708, 7962.84074318522, 9126.726198214064, 10560.947195263974, 10613.734656633645, 10836.620718274822, 10936.726581835517], "value": 9098.89148565145, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1222.0468034932755, 1340.6983428728538, 1363.9590812275633, 1430.3706369197553, 1666.5916850371661, 6620.172478440195, 7010.7195712171515, 7301.780946571598, 7309.89035164473, 7345.632718364081, 6981.441484681226, 7025.9297407025915, 7029.718811247544, 7218.278172182779, 7240.927590724091, 2136.903839327234, 2188.5622875424897, 2189.9343019709436, 2195.7913998170147, 2197.461621902636, 2132.3070002249256, 2155.7520885098256, 2169.457635591102, 2171.2400659769114, 2189.343197040889, 2131.818795402393, 2136.2736669532355, 2146.4526545730896, 2154.246013895132, 2181.0730439563204, 2076.0346438905904, 2088.2482306369693, 2088.467440802593, 2088.979110208909, 2089.5507465894752, 2066.5763518478675, 2091.0799248330686, 2107.093949601671, 2114.0381126587367, 2114.0698092839257, 7188.317109874606, 7393.8521229575645, 7445.404367650575, 7452.403807695371, 7482.962585187093, 4362.323839804835, 4459.955400445986, 4461.665375096881, 4471.82112715491, 4477.6417886569, 2895.782816288766, 2975.9404811903855, 3023.9113918989146, 3031.045220755455, 3040.8783648654025, 1004.62828753361, 1007.1741172238767, 1010.2574607663362, 1020.8315627921384, 1024.907758301749, 10457.477126143662, 10637.57449702011, 10672.0, 10720.892791072145, 10750.838737418944, 4003.939940900889, 4215.683823713233, 4236.703430759817, 4238.046439551138, 4270.380794784739, 9213.585388657526, 9247.815043699224, 9251.491167985825, 9257.814843703089, 9268.768280793034, 4635.23518619424, 4649.883752906205, 4654.953450465452, 4655.767211639404, 4668.39310889589, 3605.9278814423565, 3652.5069115669576, 4176.310908700091, 4182.623563879265, 4252.55348188442, 3548.929021419557, 3564.928701425957, 3655.670989610948, 3669.119411341259, 3671.320805650963, 1157.438642258504, 1181.2203945395997, 1193.1290158184574, 1194.9842633761234, 1202.8436303280519, 778.5990215039259, 791.0349373763999, 793.5238856686058, 794.6940427935286, 796.5897562755185, 4753.0, 4799.568038876448, 4814.735189564538, 4883.413990321184, 5066.265391518283, 376.7795839433907, 379.7341860697523, 384.5750445757454, 393.8739603326965, 394.4123256348021, 3297.472404415282, 3383.1034775784437, 3408.4205685033603, 3434.780652868246, 3484.5121682964404, 8745.475271483605, 9438.669646562337, 9476.573554190078, 9497.620095196253, 9535.0, 9251.629934802668, 9256.166944974984, 9271.67549135777, 9292.442453452815, 9302.813943721088, 6754.45964322853, 7080.185778635419, 7113.715451381887, 7124.002639630456, 7143.0, 4892.3884514435695, 4896.0, 4950.480199578992, 4955.900881982412, 4998.4251811042195, 8385.0, 8525.95737021311, 8778.824423511622, 8782.429142105742, 8840.115988401109, 7815.921840781747, 8074.071481779671, 8571.57142142903, 8604.698835540727, 8607.526586037828, 6053.0, 6231.906521402273, 6242.968785156045, 6254.3745625437095, 6261.96869015652, 6773.864522709617, 6788.355106264897, 6801.795946121624, 6835.863282734218, 6891.207511136083, 6123.173371594778, 6183.907241391473, 6212.844678882883, 6275.435210831047, 6437.871242575216, 6003.369646187088, 6022.427869352405, 6062.757489700539, 6087.482563982111, 6091.725872335667, 5461.453854614507, 5515.696636685021, 5519.613627046068, 5669.858253543694, 5848.2689663792025, 4251.893702657459, 4347.65218782503, 4349.869503914888, 4356.302991521341, 4413.205622987893, 4191.538930717679, 4236.919585505676, 4268.679849011274, 4408.845690400821, 4421.602055814992], "value": 3900.5832399283986, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.2502767776104, 287.7453453693481, 292.8111368167532, 293.90154298310074, 294.3348033444415, 4880.804767809288, 4904.337914381557, 4921.335619691341, 4921.630877684174, 4931.950680493194, 4789.437650856792, 4809.374781278438, 4840.0, 4853.733044682541, 4865.391826021747, 3590.1563132663805, 3672.5592928848578, 3780.4329350597354, 3782.243551289739, 3822.4648549203134, 3776.3202623527754, 3791.3128657747316, 3801.5058042454443, 3816.4275358696277, 3821.6942644588366, 3767.1523907120813, 3787.0, 3790.8862734117884, 3797.468354430382, 3800.410936304877, 3576.964230357702, 3647.434647629622, 3755.962440375589, 3783.0, 3812.866549670748, 3306.9173270668184, 3319.883804066846, 3319.9502007469905, 3320.352531256406, 3333.683300086512, 4683.461401938786, 4688.765561721901, 4698.154332220199, 4718.504557021498, 4748.240281554935, 4191.622753952129, 4293.377460268275, 4308.590683885026, 4309.224339618867, 4309.28896732042, 4985.950140498621, 5009.4239162496415, 5012.548870601663, 5023.32185155003, 5038.420581633122, 3608.6030536640947, 3628.8548458061646, 3630.818459077062, 3636.4181730922924, 3643.726720495947, 5159.503743914261, 5301.416844147102, 5305.920411193835, 5331.920021199685, 5336.706481143536, 3686.299603075407, 3698.593154752975, 3717.2565486902186, 3724.385476396364, 3735.6264373562426, 3790.1851102012647, 3791.639794219545, 3792.469054332396, 3799.4680744695765, 3807.809609519513, 4278.336857787048, 4281.850135245251, 4286.314189729628, 4291.3777502262, 4302.612764851178, 4856.0, 5009.824656137018, 5010.949890501121, 5082.949170508247, 5088.77100530477, 1283.671400100891, 1296.935153242334, 1301.284293638495, 1302.1275745250705, 1304.3673818198167, 813.5647428625657, 837.5844822250377, 840.2353857989323, 858.4591707224408, 862.65062649627, 4339.305711086211, 4439.223135951195, 4455.598996090367, 4456.821727130943, 4467.374567560544, 5199.7140157291715, 5217.217417387346, 5219.712915789668, 5232.964880369376, 5253.527182553512, 4458.7324760514475, 4465.553444655508, 4466.709663871838, 4474.120869234929, 4492.775361231926, 2605.4137818990575, 2752.9587056194173, 2763.571646394812, 2770.600846572468, 2777.4583956128363, 4881.291547958186, 4905.852824415273, 4911.656184067152, 4928.950710492849, 4932.28481870134, 5221.156758850464, 5277.967982326832, 5337.572994160458, 5392.299001129906, 5394.62237643369, 4806.423229212517, 4829.285603610668, 4852.80588776445, 4877.292792545061, 4916.606671466274, 5181.637285389987, 5192.9740351298005, 5205.453427390221, 5213.45258747826, 5227.817026404057, 4858.63560232991, 5055.443901170795, 5097.592192624656, 5110.284560161506, 5121.436641969306, 4824.300476430968, 4828.179209534458, 4868.3427737255015, 4882.267659851051, 4903.632227583017, 3357.630660627378, 3380.7126394256766, 3402.2988505747126, 3412.948805767866, 3417.4532074867902, 4460.888477788081, 4679.157751604744, 4689.366935463669, 4691.202495575692, 4695.460022097366, 4469.329600559812, 4492.573205545468, 4499.605122412063, 4509.977450112729, 4551.271796512542, 4441.844535441373, 4487.439070116236, 4495.460544734653, 4530.207213737649, 4530.275155975029, 4408.030233348658, 4416.580424859633, 4422.7346359218545, 4428.756418397019, 4483.574060464251, 4571.748553829571, 4692.741899195577, 5034.748262586782, 5071.290019397361, 5096.847094587169, 4922.581580565692, 4930.630202734737, 4934.901301974012, 4944.184209605375, 4945.307656928105], "value": 3750.107862175933, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.9219805326281, 602.3945934335992, 639.7824739588539, 675.9188897332318, 729.4711334282642, 12588.937055314722, 13624.863751362509, 13629.25039122848, 13633.454661813528, 13715.108517946339, 12801.743965120715, 12813.551525696603, 12816.743665126693, 12822.102452828305, 12889.677758056054, 600.2227115884939, 721.462510429728, 734.966926488308, 746.3506749128265, 748.8539734751726, 741.6810771368309, 742.8885667149917, 743.1231147246248, 745.2845268542179, 748.962551872407, 800.8478389106081, 801.7274126796888, 802.5345299726145, 803.1326167738857, 803.5018288661009, 631.6589041917382, 767.1484652036207, 792.1642666986327, 792.5522080024767, 794.7655441644729, 579.797071025142, 580.7415700013496, 581.1341101758392, 581.2443823030086, 581.2588949089902, 11514.424278786028, 11607.6517704469, 11728.824067638992, 11737.119716021247, 11789.528418863321, 11842.111841611913, 12403.62789116328, 12618.305993170372, 12729.68895194895, 13128.540501082416, 10730.463476826206, 10966.451677416097, 11032.669019929415, 11078.279911805706, 11266.493007814586, 3985.980070099631, 4002.7198096133284, 4048.736832105933, 4176.540580536139, 4197.958020419787, 61568.69215653938, 61882.0717689235, 62534.0, 62984.37015629831, 63260.0, 10307.690769276935, 10342.844857327145, 10390.48047597617, 10484.26610137283, 10515.52680129396, 19508.90245548763, 19529.218831246875, 19545.511362216057, 19580.0, 19595.804041959684, 6688.23734382002, 6810.727570897207, 6837.555558888656, 7035.8241043973285, 7112.608806515588, 3513.402721537345, 3531.611522732497, 3596.928061438809, 3609.9458508122398, 3658.579263384745, 2806.873690683924, 2902.288939209865, 2912.4466351393166, 2914.3297041680107, 2916.314666053476, 488.9071076495454, 523.0767695018296, 536.1582315764291, 544.056062731169, 554.3707891543128, 422.0753364657173, 504.4199170953433, 522.5885950977572, 523.4529916237465, 534.3614380814889, 7054.188768291712, 7116.430685545144, 7170.282971702893, 7388.741394051182, 7567.621618919032, 466.6733286699324, 488.8289098815386, 509.27428414509916, 511.1310771688145, 526.1741756106305, 3443.913902152466, 3517.191046059421, 3553.9466907996402, 3608.0, 3732.3468393031653, 58394.41605583975, 89946.10053899378, 98161.50919245358, 105923.47038264759, 106273.46863265634, 87222.0, 88997.55501222452, 90852.54573727222, 90984.54507727419, 94452.0, 44418.0, 60736.69631651814, 62920.37079629145, 63197.0, 69044.0, 7414.147373051952, 7602.657880395506, 7699.690092971974, 7839.9216007839195, 8042.67829286822, 40133.0, 43092.56907431011, 43676.781616091714, 43888.561114388445, 44436.55563444324, 62094.68952655208, 63462.365376345646, 64435.0, 64554.354456454836, 66044.66977665082, 8196.467229630294, 8503.872441913252, 8981.236594889508, 9154.542272886461, 9654.806903861743, 9767.0, 9924.1068303853, 9985.400875947467, 10128.34165779222, 10375.066244038073, 9352.812943741223, 10500.684979450629, 10755.978182072691, 10853.240273181118, 11600.883991160317, 9951.104400603981, 10433.26967112295, 10653.307535010199, 10695.358278503314, 10743.731406714895, 10128.34165779222, 10130.645427410005, 10244.282900196915, 10400.167986561208, 10864.076553493042, 8832.072632373765, 8888.73333799987, 9266.21237194846, 9291.303152263472, 9326.906730932604, 8970.237529809778, 9048.781455902377, 9491.620335186515, 9613.471259080537, 9747.171490423394], "value": 6231.639020638231, "unit": "score"}], "name": "dromaeo_css", "value": 6281.205469883869, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 118.0, 136.0, 117.0, 116.0, 115.0, 117.0, 115.0, 115.0, 116.0], "value": 118.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 122.0, 146.0, 181.0, 122.0, 148.0, 148.0, 124.0, 175.0, 134.0], "value": 145.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 159.0, 160.0, 160.0, 161.0, 162.0, 162.0, 160.0, 160.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 75.0, 166.0, 76.0, 76.0, 77.0, 76.0, 158.0, 76.0], "value": 93.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 144.0, 83.0, 83.0, 83.0, 137.0, 83.0, 84.0, 145.0], "value": 100.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, 116.0, 116.0, 118.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 70.0, 63.0, 63.0, 65.0, 65.0, 65.0, 63.0, 63.0], "value": 64.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 64.0, 65.0, 65.0, 65.0, 65.0, 65.0, 66.0], "value": 65.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 83.0, 84.0, 82.0, 81.0, 82.0, 81.0, 81.0, 87.0], "value": 82.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 144.0, 136.0, 133.0, 131.0, 133.0, 130.0, 133.0, 171.0, 133.0], "value": 138.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 175.0, 174.0, 175.0, 170.0, 170.0, 170.0, 172.0, 170.0, 173.0], "value": 172.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 74.0, 68.0, 68.0, 68.0, 68.0, 68.0, 69.0, 68.0], "value": 68.8, "unit": "score"}], "name": "kraken", "value": 1568.5, "alertThreshold": 2.0}]} 12:15:33 INFO - Return code: 0 12:15:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:15:33 INFO - # TBPL SUCCESS # 12:15:33 INFO - Running post-action listener: _resource_record_post_action 12:15:33 INFO - [mozharness: 2016-08-27 19:15:33.748813Z] Finished run-tests step (success) 12:15:33 INFO - Running post-run listener: _resource_record_post_run 12:15:33 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 424939520; Read time: 20; Write time: 289680 12:15:33 INFO - TinderboxPrint: CPU usage
13.1% 12:15:33 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 12:15:33 INFO - TinderboxPrint: I/O write bytes / time
424,939,520 / 289,680 12:15:33 INFO - TinderboxPrint: CPU idle
8,344.2 (86.9%) 12:15:33 INFO - TinderboxPrint: CPU user
1,203.8 (12.5%) 12:15:33 INFO - TinderboxPrint: Swap in / out
0 / 0 12:15:33 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 114425856; Read time: 0; Write time: 88084 12:15:33 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293777408; Read time: 20; Write time: 197052 12:15:34 INFO - Running post-run listener: _upload_blobber_files 12:15:34 INFO - Blob upload gear active. 12:15:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:15:34 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 12:15:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:15:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:15:34 INFO - Traceback (most recent call last): 12:15:34 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 253, in 12:15:34 INFO - main() 12:15:34 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 235, in main 12:15:34 INFO - filetype_whitelist = get_server_whitelist(args['--url']) 12:15:34 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 69, in get_server_whitelist 12:15:34 INFO - return set(response.json().get('whitelist', [])) 12:15:34 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/requests/models.py", line 651, in json 12:15:34 INFO - return json.loads(self.text or self.content, **kwargs) 12:15:34 INFO - File "/usr/lib/python2.7/json/__init__.py", line 326, in loads 12:15:34 INFO - return _default_decoder.decode(s) 12:15:34 INFO - File "/usr/lib/python2.7/json/decoder.py", line 366, in decode 12:15:34 INFO - obj, end = self.raw_decode(s, idx=_w(s, 0).end()) 12:15:34 INFO - File "/usr/lib/python2.7/json/decoder.py", line 384, in raw_decode 12:15:34 INFO - raise ValueError("No JSON object could be decoded") 12:15:34 INFO - ValueError: No JSON object could be decoded 12:15:34 ERROR - Return code: 1 12:15:34 INFO - Setting buildbot property blobber_files to {} 12:15:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:15:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:15:34 INFO - Contents: 12:15:34 INFO - blobber_files:{} 12:15:34 INFO - Running post-run listener: copy_logs_to_upload_dir 12:15:34 INFO - Copying logs to upload dir... 12:15:34 INFO - mkdir: /builds/slave/test/build/upload/logs 12:15:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.657844 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-08-27 12:15:34.600966) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-27 12:15:34.604487) ========= 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=826874ccc97bd7bf541b4875000001d5-1472319983.608159-278233103 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{} build_url:https://queue.taskcluster.net/v1/task/CCJe1_2gQjGZYmq1Y0tKqQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011231 build_url: 'https://queue.taskcluster.net/v1/task/CCJe1_2gQjGZYmq1Y0tKqQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-27 12:15:34.658929) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 12:15:34.659276) ========= 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=826874ccc97bd7bf541b4875000001d5-1472319983.608159-278233103 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004552 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 12:15:34.708899) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-27 12:15:34.709220) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-27 12:15:34.709503) ========= ========= Total master_lag: 0.16 =========