builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-004 starttime: 1468062858.16 results: success (0) buildid: 20160709013205 builduid: 407d8540e4834fe3abeb9dcfde5a0646 revision: 942dac3830549a98809abca0d62aeb7599c51631 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-09 04:14:18.164548) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-09 04:14:18.165238) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-09 04:14:18.165745) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-09 04:14:18.228539) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 04:14:18.228802) ========= 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=c6927cf182745ad25b1d38b9000001fe-1468061246.213790-1438631038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-09 04:14:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.9M=0s 2016-07-09 04:14:18 (43.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.131513 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 04:14:18.374559) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 04:14:18.374843) ========= 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=c6927cf182745ad25b1d38b9000001fe-1468061246.213790-1438631038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017805 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 04:14:18.423840) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 04:14:18.424162) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 942dac3830549a98809abca0d62aeb7599c51631 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 942dac3830549a98809abca0d62aeb7599c51631 --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=c6927cf182745ad25b1d38b9000001fe-1468061246.213790-1438631038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-09 04:14:19,085 truncating revision to first 12 chars 2016-07-09 04:14:19,085 Setting DEBUG logging. 2016-07-09 04:14:19,085 attempt 1/10 2016-07-09 04:14:19,085 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/942dac383054?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-09 04:14:19,722 unpacking tar archive at: mozilla-inbound-942dac383054/testing/mozharness/ program finished with exit code 0 elapsedTime=0.962649 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 04:14:19.401834) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-09 04:14:19.402213) ========= script_repo_revision: 942dac3830549a98809abca0d62aeb7599c51631 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-09 04:14:19.402609) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-09 04:14:19.402873) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-09 04:14:19.416746) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-07-09 04:14:19.417095) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=c6927cf182745ad25b1d38b9000001fe-1468061246.213790-1438631038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:14:20 INFO - MultiFileLogger online at 20160709 04:14:20 in /builds/slave/test 04:14:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 04:14:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:14:20 INFO - {'append_to_log': False, 04:14:20 INFO - 'base_work_dir': '/builds/slave/test', 04:14:20 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 04:14:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:14:20 INFO - 'branch': 'Mozilla-Inbound', 04:14:20 INFO - 'buildbot_json_path': 'buildprops.json', 04:14:20 INFO - 'config_files': ('talos/linux_config.py',), 04:14:20 INFO - 'default_actions': ('clobber', 04:14:20 INFO - 'read-buildbot-config', 04:14:20 INFO - 'download-and-extract', 04:14:20 INFO - 'populate-webroot', 04:14:20 INFO - 'create-virtualenv', 04:14:20 INFO - 'install', 04:14:20 INFO - 'run-tests'), 04:14:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:14:20 INFO - 'download_minidump_stackwalk': True, 04:14:20 INFO - 'download_symbols': 'ondemand', 04:14:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:14:20 INFO - 'tooltool.py': '/tools/tooltool.py', 04:14:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:14:20 INFO - '/tools/misc-python/virtualenv.py')}, 04:14:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:14:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:14:20 INFO - 'installer_path': 'installer.exe', 04:14:20 INFO - 'log_level': 'info', 04:14:20 INFO - 'log_name': 'talos', 04:14:20 INFO - 'log_to_console': True, 04:14:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:14:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:14:20 INFO - 'opt_config_files': (), 04:14:20 INFO - 'pip_index': False, 04:14:20 INFO - 'sps_profile': False, 04:14:20 INFO - 'sps_profile_interval': 0, 04:14:20 INFO - 'suite': 'dromaeojs', 04:14:20 INFO - 'system_bits': '32', 04:14:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:14:20 INFO - 'title': 'talos-linux64-ix-004', 04:14:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:14:20 INFO - 'use_talos_json': True, 04:14:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:14:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:14:20 INFO - 'work_dir': 'build'} 04:14:20 INFO - ##### 04:14:20 INFO - ##### Running clobber step. 04:14:20 INFO - ##### 04:14:20 INFO - Running pre-action listener: _resource_record_pre_action 04:14:20 INFO - Running main action method: clobber 04:14:20 INFO - rmtree: /builds/slave/test/build 04:14:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:14:21 INFO - Running post-action listener: _resource_record_post_action 04:14:21 INFO - ##### 04:14:21 INFO - ##### Finished clobber step (success) 04:14:21 INFO - ##### 04:14:21 INFO - ##### 04:14:21 INFO - ##### Running read-buildbot-config step. 04:14:21 INFO - ##### 04:14:21 INFO - Running pre-action listener: _resource_record_pre_action 04:14:21 INFO - Running main action method: read_buildbot_config 04:14:21 INFO - Using buildbot properties: 04:14:21 INFO - { 04:14:21 INFO - "project": "", 04:14:21 INFO - "product": "firefox", 04:14:21 INFO - "script_repo_revision": "production", 04:14:21 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 04:14:21 INFO - "repository": "", 04:14:21 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 04:14:21 INFO - "buildid": "20160709013205", 04:14:21 INFO - "pgo_build": "True", 04:14:21 INFO - "basedir": "/builds/slave/test", 04:14:21 INFO - "buildnumber": 1308, 04:14:21 INFO - "slavename": "talos-linux64-ix-004", 04:14:21 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:14:21 INFO - "platform": "ubuntu64_hw", 04:14:21 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 04:14:21 INFO - "branch": "mozilla-inbound", 04:14:21 INFO - "repo_path": "integration/mozilla-inbound", 04:14:21 INFO - "revision": "942dac3830549a98809abca0d62aeb7599c51631", 04:14:21 INFO - "stage_platform": "linux64-pgo", 04:14:21 INFO - "builduid": "407d8540e4834fe3abeb9dcfde5a0646", 04:14:21 INFO - "slavebuilddir": "test" 04:14:21 INFO - } 04:14:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/WbUEBQaJTtGR5NhfPmTf9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 04:14:21 INFO - Running post-action listener: _resource_record_post_action 04:14:21 INFO - ##### 04:14:21 INFO - ##### Finished read-buildbot-config step (success) 04:14:21 INFO - ##### 04:14:21 INFO - ##### 04:14:21 INFO - ##### Running download-and-extract step. 04:14:21 INFO - ##### 04:14:21 INFO - Running pre-action listener: _resource_record_pre_action 04:14:21 INFO - Running main action method: download_and_extract 04:14:21 INFO - mkdir: /builds/slave/test/build/tests 04:14:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:21 INFO - https://queue.taskcluster.net/v1/task/WbUEBQaJTtGR5NhfPmTf9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:14:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WbUEBQaJTtGR5NhfPmTf9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:14:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WbUEBQaJTtGR5NhfPmTf9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:14:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WbUEBQaJTtGR5NhfPmTf9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:14:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WbUEBQaJTtGR5NhfPmTf9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:14:27 INFO - Downloaded 1361 bytes. 04:14:27 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:14:27 INFO - Using the following test package requirements: 04:14:27 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:14:27 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:14:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:14:27 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:14:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:14:27 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:14:27 INFO - u'jsshell-linux-x86_64.zip'], 04:14:27 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:14:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:14:27 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:14:27 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:14:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:14:27 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:14:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:14:27 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:14:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:14:27 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:14:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:14:27 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:14:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:27 INFO - https://queue.taskcluster.net/v1/task/WbUEBQaJTtGR5NhfPmTf9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:14:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WbUEBQaJTtGR5NhfPmTf9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:14:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WbUEBQaJTtGR5NhfPmTf9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:14:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WbUEBQaJTtGR5NhfPmTf9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:14:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WbUEBQaJTtGR5NhfPmTf9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:14:31 INFO - Downloaded 24307096 bytes. 04:14:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:14:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:14:33 INFO - Return code: 0 04:14:33 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:14:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:33 INFO - https://queue.taskcluster.net/v1/task/WbUEBQaJTtGR5NhfPmTf9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:14:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WbUEBQaJTtGR5NhfPmTf9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:14:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WbUEBQaJTtGR5NhfPmTf9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:14:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WbUEBQaJTtGR5NhfPmTf9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:14:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WbUEBQaJTtGR5NhfPmTf9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:14:35 INFO - Downloaded 24307096 bytes. 04:14:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:14:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:14:36 INFO - Return code: 0 04:14:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:36 INFO - https://queue.taskcluster.net/v1/task/WbUEBQaJTtGR5NhfPmTf9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:14:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WbUEBQaJTtGR5NhfPmTf9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:14:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WbUEBQaJTtGR5NhfPmTf9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:14:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WbUEBQaJTtGR5NhfPmTf9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:14:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WbUEBQaJTtGR5NhfPmTf9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:14:37 INFO - Downloaded 14403333 bytes. 04:14:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:14:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:14:37 INFO - Return code: 0 04:14:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:37 INFO - https://queue.taskcluster.net/v1/task/WbUEBQaJTtGR5NhfPmTf9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:14:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WbUEBQaJTtGR5NhfPmTf9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:14:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WbUEBQaJTtGR5NhfPmTf9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:14:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WbUEBQaJTtGR5NhfPmTf9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:14:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WbUEBQaJTtGR5NhfPmTf9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:14:39 INFO - Downloaded 60467768 bytes. 04:14:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WbUEBQaJTtGR5NhfPmTf9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:14:39 INFO - mkdir: /builds/slave/test/properties 04:14:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:14:39 INFO - Writing to file /builds/slave/test/properties/build_url 04:14:39 INFO - Contents: 04:14:39 INFO - build_url:https://queue.taskcluster.net/v1/task/WbUEBQaJTtGR5NhfPmTf9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:14:39 INFO - Running post-action listener: _resource_record_post_action 04:14:39 INFO - Running post-action listener: set_extra_try_arguments 04:14:39 INFO - ##### 04:14:39 INFO - ##### Finished download-and-extract step (success) 04:14:39 INFO - ##### 04:14:39 INFO - ##### 04:14:39 INFO - ##### Running populate-webroot step. 04:14:39 INFO - ##### 04:14:39 INFO - Running pre-action listener: _resource_record_pre_action 04:14:39 INFO - Running main action method: populate_webroot 04:14:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:14:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:14:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:14:39 INFO - '--tppagecycles', 04:14:39 INFO - '7'], 04:14:39 INFO - 'tests': ['tsvgm']}}, 04:14:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:14:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:14:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:14:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:14:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:14:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:14:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:39 INFO - 'talos_options': ['--disable-e10s'], 04:14:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:14:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:14:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:39 INFO - 'talos_options': ['--disable-e10s'], 04:14:39 INFO - 'tests': ['damp', 'tps']}, 04:14:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:39 INFO - 'tests': ['damp', 'tps']}, 04:14:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:14:39 INFO - 'tests': ['dromaeo_dom']}, 04:14:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:14:39 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:14:39 INFO - 'tests': ['basic_compositor_video']}, 04:14:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:14:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:14:39 INFO - 'tests': ['a11yr', 04:14:39 INFO - 'ts_paint', 04:14:39 INFO - 'tpaint', 04:14:39 INFO - 'sessionrestore', 04:14:39 INFO - 'sessionrestore_no_auto_restore', 04:14:39 INFO - 'tabpaint']}, 04:14:39 INFO - 'other-e10s': {'tests': ['a11yr', 04:14:39 INFO - 'ts_paint', 04:14:39 INFO - 'tpaint', 04:14:39 INFO - 'sessionrestore', 04:14:39 INFO - 'sessionrestore_no_auto_restore', 04:14:39 INFO - 'tabpaint']}, 04:14:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:14:39 INFO - 'ts_paint', 04:14:39 INFO - 'tpaint', 04:14:39 INFO - 'sessionrestore', 04:14:39 INFO - 'sessionrestore_no_auto_restore', 04:14:39 INFO - 'tabpaint']}, 04:14:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:14:39 INFO - 'ts_paint', 04:14:39 INFO - 'tpaint', 04:14:39 INFO - 'sessionrestore', 04:14:39 INFO - 'sessionrestore_no_auto_restore', 04:14:39 INFO - 'tabpaint']}, 04:14:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:14:39 INFO - 'tests': ['a11yr', 04:14:39 INFO - 'ts_paint', 04:14:39 INFO - 'tpaint', 04:14:39 INFO - 'sessionrestore', 04:14:39 INFO - 'sessionrestore_no_auto_restore', 04:14:39 INFO - 'tabpaint']}, 04:14:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:14:39 INFO - 'tests': ['a11yr', 04:14:39 INFO - 'ts_paint', 04:14:39 INFO - 'tpaint', 04:14:39 INFO - 'sessionrestore', 04:14:39 INFO - 'sessionrestore_no_auto_restore', 04:14:39 INFO - 'tabpaint']}, 04:14:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:14:39 INFO - 'tests': ['tsvgx', 04:14:39 INFO - 'tsvgr_opacity', 04:14:39 INFO - 'tart', 04:14:39 INFO - 'tscrollx', 04:14:39 INFO - 'cart']}, 04:14:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:14:39 INFO - 'tsvgr_opacity', 04:14:39 INFO - 'tart', 04:14:39 INFO - 'tscrollx', 04:14:39 INFO - 'cart']}, 04:14:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:39 INFO - 'talos_options': ['--disable-e10s'], 04:14:39 INFO - 'tests': ['tp5o']}, 04:14:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:39 INFO - 'tests': ['tp5o']}, 04:14:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:39 INFO - 'talos_options': ['--disable-e10s', 04:14:39 INFO - '--xperf_path', 04:14:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:14:39 INFO - 'tests': ['tp5n']}, 04:14:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:39 INFO - 'talos_options': ['--xperf_path', 04:14:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:14:39 INFO - 'tests': ['tp5n']}}, 04:14:39 INFO - 'talos.zip': {'path': '', 04:14:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:14:39 INFO - Running post-action listener: _resource_record_post_action 04:14:39 INFO - ##### 04:14:39 INFO - ##### Finished populate-webroot step (success) 04:14:39 INFO - ##### 04:14:39 INFO - ##### 04:14:39 INFO - ##### Running create-virtualenv step. 04:14:39 INFO - ##### 04:14:39 INFO - Running pre-action listener: _resource_record_pre_action 04:14:39 INFO - Running main action method: create_virtualenv 04:14:39 INFO - Creating virtualenv /builds/slave/test/build/venv 04:14:39 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 04:14:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:14:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:14:39 INFO - Using real prefix '/usr' 04:14:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:14:40 INFO - Installing distribute.............................................................................................................................................................................................done. 04:14:42 INFO - Installing pip.................done. 04:14:42 INFO - Return code: 0 04:14:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:14:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:42 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 0x1741030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a02180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a003b0>, '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 0x1a012b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a01740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1468061246.213790-1438631038', '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 04:14:42 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 04:14:42 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 04:14:42 INFO - Using env: {'DISPLAY': ':0', 04:14:42 INFO - 'HOME': '/home/cltbld', 04:14:42 INFO - 'LANG': 'en_US.UTF-8', 04:14:42 INFO - 'LANGUAGE': 'en_US:en', 04:14:42 INFO - 'LOGNAME': 'cltbld', 04:14:42 INFO - 'MAIL': '/var/mail/cltbld', 04:14:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:42 INFO - 'MOZ_NO_REMOTE': '1', 04:14:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:42 INFO - 'NO_EM_RESTART': '1', 04:14:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:42 INFO - 'PWD': '/builds/slave/test', 04:14:42 INFO - 'SHELL': '/bin/bash', 04:14:42 INFO - 'SHLVL': '1', 04:14:42 INFO - 'TERM': 'linux', 04:14:42 INFO - 'TMOUT': '86400', 04:14:42 INFO - 'USER': 'cltbld', 04:14:42 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468061246.213790-1438631038', 04:14:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:42 INFO - '_': '/tools/buildbot/bin/python'} 04:14:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:42 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 04:14:42 INFO - Cleaning up... 04:14:42 INFO - Return code: 0 04:14:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:14:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:42 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 0x1741030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a02180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a003b0>, '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 0x1a012b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a01740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1468061246.213790-1438631038', '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 04:14:42 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 04:14:42 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 04:14:42 INFO - Using env: {'DISPLAY': ':0', 04:14:42 INFO - 'HOME': '/home/cltbld', 04:14:42 INFO - 'LANG': 'en_US.UTF-8', 04:14:42 INFO - 'LANGUAGE': 'en_US:en', 04:14:42 INFO - 'LOGNAME': 'cltbld', 04:14:42 INFO - 'MAIL': '/var/mail/cltbld', 04:14:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:42 INFO - 'MOZ_NO_REMOTE': '1', 04:14:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:42 INFO - 'NO_EM_RESTART': '1', 04:14:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:42 INFO - 'PWD': '/builds/slave/test', 04:14:42 INFO - 'SHELL': '/bin/bash', 04:14:42 INFO - 'SHLVL': '1', 04:14:42 INFO - 'TERM': 'linux', 04:14:42 INFO - 'TMOUT': '86400', 04:14:42 INFO - 'USER': 'cltbld', 04:14:42 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468061246.213790-1438631038', 04:14:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:42 INFO - '_': '/tools/buildbot/bin/python'} 04:14:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:42 INFO - Downloading/unpacking psutil>=3.1.1 04:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:14:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:14:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:14:44 INFO - Installing collected packages: psutil 04:14:44 INFO - Running setup.py install for psutil 04:14:44 INFO - building 'psutil._psutil_linux' extension 04:14:44 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 04:14:45 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 04:14:45 INFO - building 'psutil._psutil_posix' extension 04:14:45 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 04:14:45 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 04:14:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:14:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:14:45 INFO - Successfully installed psutil 04:14:45 INFO - Cleaning up... 04:14:45 INFO - Return code: 0 04:14:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:14:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:45 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 0x1741030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a02180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a003b0>, '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 0x1a012b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a01740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1468061246.213790-1438631038', '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 04:14:45 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 04:14:45 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 04:14:45 INFO - Using env: {'DISPLAY': ':0', 04:14:45 INFO - 'HOME': '/home/cltbld', 04:14:45 INFO - 'LANG': 'en_US.UTF-8', 04:14:45 INFO - 'LANGUAGE': 'en_US:en', 04:14:45 INFO - 'LOGNAME': 'cltbld', 04:14:45 INFO - 'MAIL': '/var/mail/cltbld', 04:14:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:45 INFO - 'MOZ_NO_REMOTE': '1', 04:14:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:45 INFO - 'NO_EM_RESTART': '1', 04:14:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:45 INFO - 'PWD': '/builds/slave/test', 04:14:45 INFO - 'SHELL': '/bin/bash', 04:14:45 INFO - 'SHLVL': '1', 04:14:45 INFO - 'TERM': 'linux', 04:14:45 INFO - 'TMOUT': '86400', 04:14:45 INFO - 'USER': 'cltbld', 04:14:45 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468061246.213790-1438631038', 04:14:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:45 INFO - '_': '/tools/buildbot/bin/python'} 04:14:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:14:45 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 04:14:45 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 04:14:45 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 04:14:45 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 04:14:45 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 04:14:45 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 04:14:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:14:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:14:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:14:47 INFO - Installing collected packages: mozsystemmonitor 04:14:47 INFO - Running setup.py install for mozsystemmonitor 04:14:47 INFO - Successfully installed mozsystemmonitor 04:14:47 INFO - Cleaning up... 04:14:47 INFO - Return code: 0 04:14:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:14:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:47 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 0x1741030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a02180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a003b0>, '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 0x1a012b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a01740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1468061246.213790-1438631038', '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 04:14:47 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 04:14:47 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 04:14:47 INFO - Using env: {'DISPLAY': ':0', 04:14:47 INFO - 'HOME': '/home/cltbld', 04:14:47 INFO - 'LANG': 'en_US.UTF-8', 04:14:47 INFO - 'LANGUAGE': 'en_US:en', 04:14:47 INFO - 'LOGNAME': 'cltbld', 04:14:47 INFO - 'MAIL': '/var/mail/cltbld', 04:14:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:47 INFO - 'MOZ_NO_REMOTE': '1', 04:14:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:47 INFO - 'NO_EM_RESTART': '1', 04:14:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:47 INFO - 'PWD': '/builds/slave/test', 04:14:47 INFO - 'SHELL': '/bin/bash', 04:14:47 INFO - 'SHLVL': '1', 04:14:47 INFO - 'TERM': 'linux', 04:14:47 INFO - 'TMOUT': '86400', 04:14:47 INFO - 'USER': 'cltbld', 04:14:47 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468061246.213790-1438631038', 04:14:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:47 INFO - '_': '/tools/buildbot/bin/python'} 04:14:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:48 INFO - Downloading/unpacking jsonschema==2.5.1 04:14:48 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 04:14:48 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 04:14:48 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 04:14:48 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 04:14:48 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 04:14:48 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 04:14:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:14:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:14:49 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 04:14:49 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 04:14:49 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 04:14:49 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 04:14:49 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 04:14:49 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 04:14:50 INFO - Downloading functools32-3.2.3-2.tar.gz 04:14:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:14:50 INFO - warning: no files found matching '*.txt' 04:14:50 INFO - no previously-included directories found matching 'build' 04:14:50 INFO - no previously-included directories found matching 'dist' 04:14:50 INFO - no previously-included directories found matching '.git*' 04:14:50 INFO - Installing collected packages: jsonschema, functools32 04:14:50 INFO - Running setup.py install for functools32 04:14:50 INFO - warning: no files found matching '*.txt' 04:14:50 INFO - no previously-included directories found matching 'build' 04:14:50 INFO - no previously-included directories found matching 'dist' 04:14:50 INFO - no previously-included directories found matching '.git*' 04:14:50 INFO - Successfully installed jsonschema functools32 04:14:50 INFO - Cleaning up... 04:14:50 INFO - Return code: 0 04:14:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:14:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:50 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 0x1741030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a02180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a003b0>, '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 0x1a012b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a01740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1468061246.213790-1438631038', '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 04:14:50 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 04:14:50 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 04:14:50 INFO - Using env: {'DISPLAY': ':0', 04:14:50 INFO - 'HOME': '/home/cltbld', 04:14:50 INFO - 'LANG': 'en_US.UTF-8', 04:14:50 INFO - 'LANGUAGE': 'en_US:en', 04:14:50 INFO - 'LOGNAME': 'cltbld', 04:14:50 INFO - 'MAIL': '/var/mail/cltbld', 04:14:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:50 INFO - 'MOZ_NO_REMOTE': '1', 04:14:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:50 INFO - 'NO_EM_RESTART': '1', 04:14:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:50 INFO - 'PWD': '/builds/slave/test', 04:14:50 INFO - 'SHELL': '/bin/bash', 04:14:50 INFO - 'SHLVL': '1', 04:14:50 INFO - 'TERM': 'linux', 04:14:50 INFO - 'TMOUT': '86400', 04:14:50 INFO - 'USER': 'cltbld', 04:14:50 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468061246.213790-1438631038', 04:14:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:50 INFO - '_': '/tools/buildbot/bin/python'} 04:14:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:50 INFO - Downloading/unpacking blobuploader==1.2.4 04:14:50 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 04:14:50 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 04:14:50 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 04:14:50 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 04:14:50 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 04:14:50 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 04:14:52 INFO - Downloading blobuploader-1.2.4.tar.gz 04:14:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:14:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:14:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:14:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:14:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:53 INFO - Downloading docopt-0.6.1.tar.gz 04:14:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:14:53 INFO - Installing collected packages: blobuploader, requests, docopt 04:14:53 INFO - Running setup.py install for blobuploader 04:14:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:14:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:14:53 INFO - Running setup.py install for requests 04:14:53 INFO - Running setup.py install for docopt 04:14:53 INFO - Successfully installed blobuploader requests docopt 04:14:53 INFO - Cleaning up... 04:14:53 INFO - Return code: 0 04:14:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:14: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:53 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 0x1741030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a02180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a003b0>, '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 0x1a012b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a01740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1468061246.213790-1438631038', '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 04:14:53 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 04:14:53 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 04:14:53 INFO - Using env: {'DISPLAY': ':0', 04:14:53 INFO - 'HOME': '/home/cltbld', 04:14:53 INFO - 'LANG': 'en_US.UTF-8', 04:14:53 INFO - 'LANGUAGE': 'en_US:en', 04:14:53 INFO - 'LOGNAME': 'cltbld', 04:14:53 INFO - 'MAIL': '/var/mail/cltbld', 04:14:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:53 INFO - 'MOZ_NO_REMOTE': '1', 04:14:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:53 INFO - 'NO_EM_RESTART': '1', 04:14:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:53 INFO - 'PWD': '/builds/slave/test', 04:14:53 INFO - 'SHELL': '/bin/bash', 04:14:53 INFO - 'SHLVL': '1', 04:14:53 INFO - 'TERM': 'linux', 04:14:53 INFO - 'TMOUT': '86400', 04:14:53 INFO - 'USER': 'cltbld', 04:14:53 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468061246.213790-1438631038', 04:14:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:53 INFO - '_': '/tools/buildbot/bin/python'} 04:14:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:14:54 INFO - Running setup.py (path:/tmp/pip-9gtj2T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:14:54 INFO - Running setup.py (path:/tmp/pip-At2o5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:14:54 INFO - Running setup.py (path:/tmp/pip-UYP80X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:14:54 INFO - Running setup.py (path:/tmp/pip-MfNk4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:14:54 INFO - Running setup.py (path:/tmp/pip-SrDZrU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:14:54 INFO - Running setup.py (path:/tmp/pip-TeGIrc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:14:54 INFO - Running setup.py (path:/tmp/pip-C9RlBA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:14:54 INFO - Running setup.py (path:/tmp/pip-0_bFdp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:14:54 INFO - Running setup.py (path:/tmp/pip-FpXrja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:14:54 INFO - Running setup.py (path:/tmp/pip-rL57HY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:14:54 INFO - Running setup.py (path:/tmp/pip-KQHwKJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:14:54 INFO - Running setup.py (path:/tmp/pip-w0gy0Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:14:54 INFO - Running setup.py (path:/tmp/pip-hq19WI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:14:54 INFO - Running setup.py (path:/tmp/pip-1Yu7m_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:55 INFO - Running setup.py (path:/tmp/pip-gw3uaF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:14:55 INFO - Running setup.py (path:/tmp/pip-81AmQN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:14:55 INFO - Running setup.py (path:/tmp/pip-7k_MzT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:14:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:14:55 INFO - Running setup.py install for manifestparser 04:14:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:14:55 INFO - Running setup.py install for mozcrash 04:14:55 INFO - Running setup.py install for mozdebug 04:14:55 INFO - Running setup.py install for mozdevice 04:14:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:14:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:14:55 INFO - Running setup.py install for mozfile 04:14:55 INFO - Running setup.py install for mozhttpd 04:14:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:14:55 INFO - Running setup.py install for mozinfo 04:14:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:14:55 INFO - Running setup.py install for mozInstall 04:14:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:14:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:14:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:14:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:14:56 INFO - Running setup.py install for mozleak 04:14:56 INFO - Running setup.py install for mozlog 04:14:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:14:56 INFO - Running setup.py install for moznetwork 04:14:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:14:56 INFO - Running setup.py install for mozprocess 04:14:56 INFO - Running setup.py install for mozprofile 04:14:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:14:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:14:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:14:56 INFO - Running setup.py install for mozrunner 04:14:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:14:56 INFO - Running setup.py install for mozscreenshot 04:14:56 INFO - Running setup.py install for moztest 04:14:56 INFO - Running setup.py install for mozversion 04:14:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:14:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:14:57 INFO - Cleaning up... 04:14:57 INFO - Return code: 0 04:14:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:14:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:57 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 0x1741030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a02180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a003b0>, '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 0x1a012b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a01740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1468061246.213790-1438631038', '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 04:14:57 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 04:14:57 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 04:14:57 INFO - Using env: {'DISPLAY': ':0', 04:14:57 INFO - 'HOME': '/home/cltbld', 04:14:57 INFO - 'LANG': 'en_US.UTF-8', 04:14:57 INFO - 'LANGUAGE': 'en_US:en', 04:14:57 INFO - 'LOGNAME': 'cltbld', 04:14:57 INFO - 'MAIL': '/var/mail/cltbld', 04:14:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:57 INFO - 'MOZ_NO_REMOTE': '1', 04:14:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:57 INFO - 'NO_EM_RESTART': '1', 04:14:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:57 INFO - 'PWD': '/builds/slave/test', 04:14:57 INFO - 'SHELL': '/bin/bash', 04:14:57 INFO - 'SHLVL': '1', 04:14:57 INFO - 'TERM': 'linux', 04:14:57 INFO - 'TMOUT': '86400', 04:14:57 INFO - 'USER': 'cltbld', 04:14:57 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468061246.213790-1438631038', 04:14:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:57 INFO - '_': '/tools/buildbot/bin/python'} 04:14:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:14:57 INFO - Running setup.py (path:/tmp/pip-8SGhii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:14:57 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)) 04:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:14:57 INFO - Running setup.py (path:/tmp/pip-W8p7Y0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:14:57 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)) 04:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:14:57 INFO - Running setup.py (path:/tmp/pip-1859O5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:14:57 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)) 04:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:14:57 INFO - Running setup.py (path:/tmp/pip-i65OzP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:14:57 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)) 04:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:14:57 INFO - Running setup.py (path:/tmp/pip-MDmeUV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:14:57 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)) 04:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:14:57 INFO - Running setup.py (path:/tmp/pip-wRWrxP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:14:57 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)) 04:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:14:57 INFO - Running setup.py (path:/tmp/pip-MLD_kG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:14:57 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)) 04:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:14:57 INFO - Running setup.py (path:/tmp/pip-N2axUF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:14:57 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)) 04:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:14:57 INFO - Running setup.py (path:/tmp/pip-e8mKNt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:14:57 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)) 04:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:14:57 INFO - Running setup.py (path:/tmp/pip-dkQaAT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:14:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:14:58 INFO - Running setup.py (path:/tmp/pip-NiNZZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:14:58 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)) 04:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:14:58 INFO - Running setup.py (path:/tmp/pip-VK1qOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:14:58 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)) 04:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:14:58 INFO - Running setup.py (path:/tmp/pip-uXfx9P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:14:58 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)) 04:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:14:58 INFO - Running setup.py (path:/tmp/pip-B06UL3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:14:58 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)) 04:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:58 INFO - Running setup.py (path:/tmp/pip-uBcgZA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:58 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)) 04:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:14:58 INFO - Running setup.py (path:/tmp/pip-FGKPod-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:14:58 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)) 04:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:14:58 INFO - Running setup.py (path:/tmp/pip-MHQ95u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:14:58 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)) 04:14:58 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)) 04:14:58 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)) 04:14:58 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)) 04:14:58 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)) 04:14:58 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)) 04:14:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:14:58 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 04:14:58 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 04:14:58 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 04:14:58 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 04:14:58 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 04:14:58 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 04:15:00 INFO - Downloading blessings-1.6.tar.gz 04:15:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:15:00 INFO - Installing collected packages: blessings 04:15:00 INFO - Running setup.py install for blessings 04:15:00 INFO - Successfully installed blessings 04:15:00 INFO - Cleaning up... 04:15:00 INFO - Return code: 0 04:15:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:15:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:15:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:15:00 INFO - Reading from file tmpfile_stdout 04:15:00 INFO - Current package versions: 04:15:00 INFO - argparse == 1.2.1 04:15:00 INFO - blessings == 1.6 04:15:00 INFO - blobuploader == 1.2.4 04:15:00 INFO - docopt == 0.6.1 04:15:00 INFO - functools32 == 3.2.3-2 04:15:00 INFO - jsonschema == 2.5.1 04:15:00 INFO - manifestparser == 1.1 04:15:00 INFO - mozInstall == 1.12 04:15:00 INFO - mozcrash == 0.17 04:15:00 INFO - mozdebug == 0.1 04:15:00 INFO - mozdevice == 0.48 04:15:00 INFO - mozfile == 1.2 04:15:00 INFO - mozhttpd == 0.7 04:15:00 INFO - mozinfo == 0.9 04:15:00 INFO - mozleak == 0.1 04:15:00 INFO - mozlog == 3.2 04:15:00 INFO - moznetwork == 0.27 04:15:00 INFO - mozprocess == 0.23 04:15:00 INFO - mozprofile == 0.28 04:15:00 INFO - mozrunner == 6.12 04:15:00 INFO - mozscreenshot == 0.1 04:15:00 INFO - mozsystemmonitor == 0.3 04:15:00 INFO - moztest == 0.7 04:15:00 INFO - mozversion == 1.4 04:15:00 INFO - psutil == 3.1.1 04:15:00 INFO - requests == 1.2.3 04:15:00 INFO - wsgiref == 0.1.2 04:15:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:15:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:15:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:15:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:15:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:00 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 0x1741030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a02180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a003b0>, '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 0x1a012b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a01740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1468061246.213790-1438631038', '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 04:15:00 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 04:15:00 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 04:15:00 INFO - Using env: {'DISPLAY': ':0', 04:15:00 INFO - 'HOME': '/home/cltbld', 04:15:00 INFO - 'LANG': 'en_US.UTF-8', 04:15:00 INFO - 'LANGUAGE': 'en_US:en', 04:15:00 INFO - 'LOGNAME': 'cltbld', 04:15:00 INFO - 'MAIL': '/var/mail/cltbld', 04:15:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:00 INFO - 'MOZ_NO_REMOTE': '1', 04:15:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:15:00 INFO - 'NO_EM_RESTART': '1', 04:15:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:15:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:15:00 INFO - 'PWD': '/builds/slave/test', 04:15:00 INFO - 'SHELL': '/bin/bash', 04:15:00 INFO - 'SHLVL': '1', 04:15:00 INFO - 'TERM': 'linux', 04:15:00 INFO - 'TMOUT': '86400', 04:15:00 INFO - 'USER': 'cltbld', 04:15:00 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468061246.213790-1438631038', 04:15:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:00 INFO - '_': '/tools/buildbot/bin/python'} 04:15:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:15:01 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)) 04:15:01 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)) 04:15:01 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)) 04:15:01 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)) 04:15:01 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)) 04:15:01 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)) 04:15:01 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)) 04:15:01 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)) 04:15:01 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)) 04:15:01 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)) 04:15:01 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)) 04:15:01 INFO - Cleaning up... 04:15:01 INFO - Return code: 0 04:15:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:15:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:15:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:15:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:15:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:01 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 0x1741030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a02180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a003b0>, '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 0x1a012b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a01740>, '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': 'c6927cf182745ad25b1d38b9000001fe-1468061246.213790-1438631038', '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 04:15:01 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 04:15:01 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 04:15:01 INFO - Using env: {'DISPLAY': ':0', 04:15:01 INFO - 'HOME': '/home/cltbld', 04:15:01 INFO - 'LANG': 'en_US.UTF-8', 04:15:01 INFO - 'LANGUAGE': 'en_US:en', 04:15:01 INFO - 'LOGNAME': 'cltbld', 04:15:01 INFO - 'MAIL': '/var/mail/cltbld', 04:15:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:01 INFO - 'MOZ_NO_REMOTE': '1', 04:15:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:15:01 INFO - 'NO_EM_RESTART': '1', 04:15:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:15:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:15:01 INFO - 'PWD': '/builds/slave/test', 04:15:01 INFO - 'SHELL': '/bin/bash', 04:15:01 INFO - 'SHLVL': '1', 04:15:01 INFO - 'TERM': 'linux', 04:15:01 INFO - 'TMOUT': '86400', 04:15:01 INFO - 'USER': 'cltbld', 04:15:01 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468061246.213790-1438631038', 04:15:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:01 INFO - '_': '/tools/buildbot/bin/python'} 04:15:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:15:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:15:01 INFO - Cleaning up... 04:15:01 INFO - Return code: 0 04:15:01 INFO - Running post-action listener: _resource_record_post_action 04:15:01 INFO - Running post-action listener: _start_resource_monitoring 04:15:01 INFO - Starting resource monitoring. 04:15:01 INFO - ##### 04:15:01 INFO - ##### Finished create-virtualenv step (success) 04:15:01 INFO - ##### 04:15:01 INFO - ##### 04:15:01 INFO - ##### Running install step. 04:15:01 INFO - ##### 04:15:01 INFO - Running pre-action listener: _resource_record_pre_action 04:15:01 INFO - Running main action method: install 04:15:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:15:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:15:01 INFO - Reading from file tmpfile_stdout 04:15:01 INFO - Detecting whether we're running mozinstall >=1.0... 04:15:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:15:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:15:01 INFO - Reading from file tmpfile_stdout 04:15:01 INFO - Output received: 04:15:01 INFO - Usage: mozinstall [options] installer 04:15:01 INFO - Options: 04:15:01 INFO - -h, --help show this help message and exit 04:15:01 INFO - -d DEST, --destination=DEST 04:15:01 INFO - Directory to install application into. [default: 04:15:01 INFO - "/builds/slave/test"] 04:15:01 INFO - --app=APP Application being installed. [default: firefox] 04:15:01 INFO - mkdir: /builds/slave/test/build/application 04:15:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:15:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:15:18 INFO - Reading from file tmpfile_stdout 04:15:18 INFO - Output received: 04:15:18 INFO - /builds/slave/test/build/application/firefox/firefox 04:15:18 INFO - Running post-action listener: _resource_record_post_action 04:15:18 INFO - ##### 04:15:18 INFO - ##### Finished install step (success) 04:15:18 INFO - ##### 04:15:18 INFO - ##### 04:15:18 INFO - ##### Running run-tests step. 04:15:18 INFO - ##### 04:15:18 INFO - Running pre-action listener: _resource_record_pre_action 04:15:18 INFO - Running main action method: run_tests 04:15:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:15:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:15:18 INFO - Python 2.7.3 04:15:18 INFO - Return code: 0 04:15:18 INFO - grabbing minidump binary from tooltool 04:15:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:15:18 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 0x1a003b0>, '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 0x1a012b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a01740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:15:18 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 04:15:18 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 04:15:18 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 04:15:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:15:18 INFO - Return code: 0 04:15:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:15:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:15:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:15:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:15:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:15:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WbUEBQaJTtGR5NhfPmTf9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 04:15:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WbUEBQaJTtGR5NhfPmTf9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --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 04:15:18 INFO - Using env: {'DISPLAY': ':0', 04:15:18 INFO - 'HOME': '/home/cltbld', 04:15:18 INFO - 'LANG': 'en_US.UTF-8', 04:15:18 INFO - 'LANGUAGE': 'en_US:en', 04:15:18 INFO - 'LOGNAME': 'cltbld', 04:15:18 INFO - 'MAIL': '/var/mail/cltbld', 04:15:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:15:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:15:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:18 INFO - 'MOZ_NO_REMOTE': '1', 04:15:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:15:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:15:18 INFO - 'NO_EM_RESTART': '1', 04:15:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:15:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:15:18 INFO - 'PWD': '/builds/slave/test', 04:15:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:15:18 INFO - 'SHELL': '/bin/bash', 04:15:18 INFO - 'SHLVL': '1', 04:15:18 INFO - 'TERM': 'linux', 04:15:18 INFO - 'TMOUT': '86400', 04:15:18 INFO - 'USER': 'cltbld', 04:15:18 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1468061246.213790-1438631038', 04:15:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:18 INFO - '_': '/tools/buildbot/bin/python'} 04:15:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WbUEBQaJTtGR5NhfPmTf9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 04:15:19 INFO - mozversion application_buildid: 20160709013205 04:15:19 INFO - mozversion application_changeset: 942dac3830549a98809abca0d62aeb7599c51631 04:15:19 INFO - mozversion application_display_name: Nightly 04:15:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:15:19 INFO - mozversion application_name: Firefox 04:15:19 INFO - mozversion application_remotingname: firefox 04:15:19 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:15:19 INFO - mozversion application_vendor: Mozilla 04:15:19 INFO - mozversion application_version: 50.0a1 04:15:19 INFO - mozversion platform_buildid: 20160709013205 04:15:19 INFO - mozversion platform_changeset: 942dac3830549a98809abca0d62aeb7599c51631 04:15:19 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:15:19 INFO - mozversion platform_version: 50.0a1 04:15:19 INFO - using testdate: 1468062919 04:15:19 INFO - actual date: 1468062919 04:15:19 INFO - starting webserver on 'localhost:35259' 04:15:19 INFO - SUITE-START | Running 2 tests 04:15:19 INFO - TEST-START | dromaeo_css 04:15:19 INFO - operating with platform_type : linux_ 04:15:19 INFO - Initialising browser for dromaeo_css test... 04:15:19 INFO - TEST-INFO | started process 8532 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNMVPvL/profile http://localhost:35259/getInfo.html) 04:15:23 INFO - PROCESS | 8532 | __metrics Screen width/height:1600/1200 04:15:23 INFO - PROCESS | 8532 | colorDepth:24 04:15:23 INFO - PROCESS | 8532 | Browser inner width/height: 1024/697 04:15:23 INFO - PROCESS | 8532 | __metrics 04:15:24 INFO - PROCESS | 8532 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:15:24 INFO - TEST-INFO | 8532: exit 0 04:15:24 INFO - Browser initialized. 04:15:24 INFO - Running cycle 1/1 for dromaeo_css test... 04:15:25 INFO - TEST-INFO | started process 8618 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNMVPvL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:15:36 INFO - PROCESS | 8618 | RSS: Main: 157786112 04:15:36 INFO - PROCESS | 8618 | 04:16:28 INFO - PROCESS | 8618 | 1468062988183 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] 04:18:35 INFO - PROCESS | 8618 | Cycle 1(1): loaded http://localhost:35259/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35259/tests/dromaeo/cssquery-ext.html) 04:18:36 INFO - PROCESS | 8618 | RSS: Main: 248610816 04:18:36 INFO - PROCESS | 8618 | 04:21:39 INFO - PROCESS | 8618 | Cycle 1(1): loaded http://localhost:35259/tests/dromaeo/cssquery-ext.html (next: http://localhost:35259/tests/dromaeo/cssquery-jquery.html) 04:21:39 INFO - PROCESS | 8618 | RSS: Main: 240291840 04:21:39 INFO - PROCESS | 8618 | 04:24:41 INFO - PROCESS | 8618 | Cycle 1(1): loaded http://localhost:35259/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35259/tests/dromaeo/cssquery-mootools.html) 04:24:42 INFO - PROCESS | 8618 | RSS: Main: 245059584 04:24:42 INFO - PROCESS | 8618 | 04:27:44 INFO - PROCESS | 8618 | Cycle 1(1): loaded http://localhost:35259/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35259/tests/dromaeo/cssquery-prototype.html) 04:27:44 INFO - PROCESS | 8618 | RSS: Main: 235380736 04:27:44 INFO - PROCESS | 8618 | 04:30:47 INFO - PROCESS | 8618 | Cycle 1(1): loaded http://localhost:35259/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35259/tests/dromaeo/cssquery-yui.html) 04:30:48 INFO - PROCESS | 8618 | RSS: Main: 229142528 04:30:48 INFO - PROCESS | 8618 | 04:33:50 INFO - PROCESS | 8618 | Cycle 1(1): loaded http://localhost:35259/tests/dromaeo/cssquery-yui.html (next: http://localhost:35259/tests/dromaeo/cssquery-dojo.html) 04:33:50 INFO - PROCESS | 8618 | RSS: Main: 305205248 04:33:50 INFO - PROCESS | 8618 | 04:33:50 INFO - PROCESS | 8618 | __start_tp_report 04:33:50 INFO - PROCESS | 8618 | _x_x_mozilla_page_load 04:33:50 INFO - PROCESS | 8618 | _x_x_mozilla_page_load_details 04:33:50 INFO - PROCESS | 8618 | |i|pagename|runs| 04:33:50 INFO - PROCESS | 8618 | |0;dojo.html;2999.2501874531367;3004.4291584598936;3041.057272245603;3049.7560195184387;3054.755619550436;5090.363704536933;5151.536361727443;5151.639385243035;5260.579153667707;5315.734213289335;5158.638895277322;5174.379074511055;5179.585633149349;5199.584033277338;5236.1098613235745;4634.8146074157075;4734.786934587952;4739.028499157665;4795.688280261789;4825.348577941968;4703.670743047988;4744.928826067612;4759.571638552529;4793.568578827905;4806.279058141289;4594.264917613183;4655.674102812804;4717;4717.221658426355;4755.334253204554;4712.034033023222;4728.148933192024;4742.288656701522;4790.113828941622;4837.879053023667;4744.976275118637;4756.500567440438;4762.809487620491;4774.73738944358;4811.350467686852;5067.189249720064;5155.278261043457;5222.190560463135;5238.476152384769;5243.082460569385;5553.333599967989;5560.138178582286;5591.832245032656;5591.860203494904;5592.5805564582415;5376.650517716336;5571.052921003439;5612.915806262909;5621.437856214387;5623.971880140573;5125.84622461323;5177.430482646906;5189.221616757516;5240.056789777838;5263.763130659129;5699.202111704365;5704.629199102045;5744.4829965303325;5770.88458230833;5771.971140144273;5314.97342513285;5351.812686555952;5509.5041446270025;5513.61404701667;5523.8066667666435;5496.120620700749;5577.024020796344;5582.665040097607;5584.162375643605;5589.189567512688;5459.481349271813;5491.066518691752;5491.121420572689;5495.807646732425;5525.171224316305;5316.680999140064;5409.972950135224;5452.509274165344;5463.617546771768;5468.644538105011;4242.321228603409;4245.766482843474;4248.171606536695;4282.550332215073;4285.0358669299785;3798.6961043116485;3808;3810.0855794609092;3841.7118716096406;3848.499695039627;5181.222816577543;5218.817341393109;5233.293505376725;5282.97358513205;5296.364436267672;5536.972315138399;5564.666120032811;5568.1091025435735;5572.860678482989;5616;5296.285001524822;5306.973465132727;5309.283246761715;5319.867003324948;5324.307839980777;4622.144903192853;4646.674732768742;4661.627069834405;4662.7202367858035;4673.719576825401;5677.659340439504;5682.119271512922;5682.545396368363;5687.317521897481;5689.601727879009;5428.592855535771;5479.2602998594675;5479.945200547943;5480.671159730429;5526.253955715927;5568.721563921868;5643.858903527444;5699.686517241592;5728.283964504437;5761.942380576308;5429.131338985743;5431.429699881455;5443.455654434525;5443.591730620298;5446.509814116748;5445.210444485607;5502.697351645538;5519.365272993497;5527.078004160475;5572.275604171432;5367.329083864517;5459.317585301837;5478.726063696879;5498.917516237339;5505.119180931032;5435.836924892102;5441.755121019484;5449.427810079885;5452.781888724565;5453.10023846061;5291.682499050069;5354.571634269327;5386.434424385383;5438.150888976517;5497.367802702581;5430.6198566101575;5498.065328894178;5530.032244357302;5531.0873705838085;5554.08357620988;5379.757910893941;5383.16560933056;5396.1366181410785;5397.325334333208;5400.270963419888 04:33:50 INFO - PROCESS | 8618 | |1;ext.html;596.674812227336;616.1866336435904;633.5723386713967;633.6736580660961;634.2579182356642;32507;35794.642053579424;35836.46245306319;43178.35232471515;44414.11171776563;45208.321875171816;45587.08825823481;45736.08527829441;45746.77126614362;45811;8900.109989001081;9047.366684332066;9048.864267036;9052.8642070369;9057;8957.865632015524;9050.683226087089;9057.275417966546;9061.592228349708;9062.501562414065;9095.499747513884;9147.862782058275;9153.535434330508;9162.129597688208;9164.450132992042;8972.820543589158;9053.366264361497;9079.002619423716;9088.954555227214;9092.227160691316;8809.251213646849;8809.911900880974;8884.644614215424;8890.644374225023;8892.688755893578;43186;43614.78192609049;43694.56305436968;43703.12593748139;43717.9397442176;3620.131168519563;3687.2994131115;3717.312297224995;3819.618038196158;4162.542120366757;31071.223219419695;31613.683863161536;31776.523352149736;31791.682083179105;32314.192145196324;4262.87211383659;4365.781710914442;4423.270160423526;4493.303537951622;4493.842715504941;342154;343116;344425;345262;346536;57318.713406432704;57510;57858.710706446196;57878.42121578815;57960.710196448745;61534.38465615286;61677.22452489649;61877;61954.69022654858;61984;16363.427280045142;16614.83385166133;16630.750538741686;16642.417515386904;16647.667046659;12934.547290844775;12971.545995890287;13003.349832508336;13007.609771706864;13013.479460821462;15660.765088523682;16671.666566668842;16694.08182549947;16727.247273872705;16811.57971050709;5654.321481422174;5690.829275121753;5749.195112684228;5771.422857714279;5879.853003674943;1004.6584161385164;1010.7018429563296;1012.9594816207417;1072.978540429187;1133.3143448213877;32848.1787955303;33227.83386083054;33293.83353083268;33305.50041749376;33713.15717107092;1134.5688638317552;1140.201858698914;1151.7523732397574;1164.2956011612853;1194.1819853400448;16821.243044063045;17315.740263896052;17493.475195744148;17507.124643767762;17538.649227015645;501535;501754;503998;504618.4769076131;504860;57850.71074644684;57892.71053644705;57971;58021.12968305479;58097.128543071885;1224.975500490003;1335.6460537957448;1349.9527516536873;1390.610629023875;1392.679683672761;32949.83525082359;33826.32347353089;33962.320753585285;34000.489992650626;34095.31809363848;49116.75441622769;49841.25238121504;49934.25098623451;50012;50018.49981500284;369472;371643;372531;374536;374862;34155.31689366149;39309.41035884407;40125.59874401218;41290;44228.798264164856;47935;49136.508634913196;49348;49624;50178;39655.80172099121;41379.58620413757;41561;41843.37234941539;42686.146277074906;41614.791926040176;41942.37086443767;42100.36849447322;42586.148277033666;43097.35353969756;41648.58351416447;41716;42302;42438.36342454927;42538.78730606327;35044.85721820626;36953.44569831508;37247.6275237255;37570.8121459391;37588;28112;28181.71818281873;28401.28996775097;28415.43169136647;28418.431631366842 04:33:50 INFO - PROCESS | 8618 | |2;jquery.html;392.75649097559517;397.6282176165285;401.6706300833318;403.95758445363236;418.09839712395967;13304.800427993589;18459.446216613505;19511.121999510022;20137.899310503446;20165.697514537293;14322.9895629224;17515.91242043791;18140.909295453537;19039.238430462763;19446.70829937552;5738.99999999999;5901.232839730829;5913.852153696171;5935.64386136831;5945.137954996523;5814.97092514539;5878.059510478324;5883.705814709268;5885.764569417218;5897.587168898179;4147.668186545085;4334.436523251973;5587.329520457551;6433.742650294006;6497.090407342976;6299.149614801989;6458.741650333981;6640.800775976729;6651.035599838021;6653.667316634149;5592.832215033555;5614.438556144394;5636.15457681347;5638.802641907555;5643.8589035274035;21823.236186733546;23071.307860764206;23207.419814504774;23290.767092329028;23312.417189570395;2315.351701523576;2394.5330660521204;2486.27897909606;2663.3208531824453;2924.0496838527565;14062.578122656336;14724.55826325212;15037.248137593077;15231.390744370323;15410.614734631725;1946.9415917522497;1963.5680150367039;1965.2040923425893;1994.5611965367596;2012.3761633893394;53279.20081198785;53300.20049699258;53705.731471342784;83099.5845020777;87719.12280877237;11093.778124437466;11213.10295176384;11305.773884522263;11385.316880987168;11411.657650270505;15340.616484587974;15473.458428955159;15541.456049038456;15546.533603991898;15572.454964076429;7849.646765895548;8019.518828870287;8136.593170341459;8139.552324622203;8264.090949995496;8030.478018928751;8049.87925181111;8135.959320203361;8264.380171487162;8274.751757447286;4291.206126866539;4384.276594361894;4810.831620893252;4819.7108173509705;4903.387076615423;1821.7624330051103;1949.9902500487406;1957.412776167144;1976.7726711428081;1987.0492318906413;926.7405126564573;982.474376208725;1031.8916513766096;1046.0480962324248;1079.228351728518;19274.22903083861;19514.219431222875;19679.50801229952;19711.901440492707;19998.600027999357;980;985.2069084386994;1002.734275417015;1006.2905651515664;1009.8333774927055;10777.137828973664;10957.945210274058;11008.889911100947;11049.447527623586;11069.335839849635;180526;181872;182178;182494;184363.07818460822;61091.69454152701;64384;69669.65165174243;85780;107564;982.6020461713018;989.3766926836047;1012.8581998520214;1023.9641612543376;1026.712520494263;18020.54948626295;18205.726914096034;18460.26158953627;18637.068146592344;18836.434906952814;32809.50785738263;36816;43880.56119438765;45100.77449612731;46125.30812037889;61614.383856160865;62781.68609156925;63472.36527634849;63794.68102659457;63838.68080659567;8612.569371531523;8873.245774109273;8948.284137269133;8977.685780997634;9242.306826988137;8975.910240897507;13267.40296686632;13563;13936.372863220977;14146.575602731935;12236.388180591113;12281.447334869774;12363.876361236273;12465.439055242718;12505.812412813997;10695.786084278427;12037.157398981988;12118.818217726564;12360.629181124581;12470.189437686522;12287.078469115031;12610.117291789487;12646;12663.683407914876;12673.366331683195;8786.604602793017;9068.773280668036;9070.863937041082;9098.36311458218;9144.679936202201;11726.120540959633;11903.583374582195;11951.641450756491;12038.75922481528;12357.814632780335 04:33:50 INFO - PROCESS | 8618 | |3;mootools.html;1491.433255362962;1505.5031839492967;1659.8257182995785;1747.3272789975856;1774.5297496163519;8171.550564718938;8697.347698922575;8720.389572729911;8745.693900713477;8794.296456283499;7408.5554866708035;7580.1661817200065;7595.77212683619;7853;8595.269402100814;2185.595664802013;2263.9660405093937;2290.6793048973072;2300;2303.873286969216;2238.418011317061;2263.411513006614;2265.2864347730497;2282.611955967481;2284.942876428094;1779.9199036043344;2179.7711240319777;2255.7744225577394;2261.276391554695;2262;2241.8879056047213;2291.942701432469;2296.5292115116363;2300.459392042869;2300.6318988961852;2189.901454434554;2195.6157672407426;2205.1289740552393;2209.4807720185904;2236.2955668964387;8571.528565928871;8680.6527738891;8681;8684.39209255346;8684.565771711452;5019.071471777733;5189.065968125736;5192.039472697563;5197.532222100029;5203.453637368098;3247.1395080303737;3360.311136217094;3385.4244778387733;3420.2817408344276;3430.6740859618294;1014.0467960117466;1032.9948350258276;1046.3721766939852;1064.356064580925;1068.2522234435849;11897.167198296209;11932.940335298355;11945.820812687729;11950.880491195063;11959.581414650445;4282.614564689193;4511.233090374579;4550.49944506104;4590.632749380042;4593.448786145617;10012.649557265606;10036;10049.296549241482;10051.49742512886;10051.64819231338;5089.821856235014;5104.795808167632;5116.462771409023;5120.820771272987;5127.4872512748425;3953.150072734376;4463.196624607602;4688.507706690816;4697.859064228079;4700.130475861976;3871.2257548490416;3893.3381325174787;3947.407888816643;3964.0882597002274;4007.0583412897945;1167.6788883057056;1173.0791328807015;1177.4289469607234;1183.7040739815047;1213.2720367779261;878.7100256915203;989.618996686281;991.980160396788;996.0836030851634;1008.1481148429565;5625.071863142617;5645.491905728422;5789.681567513743;5802.796902108406;5809.390014048464;437.093031958687;440.583648452216;443.94894587122246;445.10311721880436;996.9401835889724;4046.109855831712;4064;4075.7962101895378;4144.626983571493;4146.170765846843;10486.37081775096;10645.893541064645;10697.625583104555;10711.303765255234;10712.571497140027;10454.738631534272;10514.789704205874;10563.577456901792;10586.841197382046;10655.413952232546;7393.519421237603;7724.382049436032;7736.187700291501;7921.405894557816;7931.405144614177;5656.830295091154;6067.271927368567;6138.815835524942;6195.81412557624;6300.495960323255;9700.563474643517;9846.458444785605;9942.900570994198;10040.497975101362;10050.346727462691;9849.556769945226;10059.748506287402;10166.288359814742;10277.075063244343;10314.535845886803;7002.614856182959;7830.177831327628;7864.84270314602;7998.280154786097;8173.141820108803;8263.95868020656;8420.031696354752;8474.533900635524;8477.576121193792;8481.194286542768;7355.1541572719825;7433.331000210007;7515.098188217449;7592.126905405949;7721.7683469496005;7203.639818009184;7266.309700578437;7342.302481264272;7541;7568.697252109854;6661.633610151294;6698.966505167443;6705.631190284581;6715.3620406061345;6744.460443164437;4976.2286845539;5073.898522029613;5152.896942061213;5190.299309593308;5211.166213405837;4802.807887684593;4863.124637565131;4898.069366820293;4899.632527560376;4920.975395123001 04:33:50 INFO - PROCESS | 8618 | |4;prototype.html;318.14736506163484;319.99360012799747;326.3424200236522;328.5892634207241;329.4777777223101;5243.344581927259;5269.920951185735;5270.683758974455;5272.340957380327;5279.313689220406;5181.222816577515;5189.8183563575285;5218.634695571312;5229.2156176573535;5229.50319719627;3907.902302442433;3982.1637456134245;4103.199876024177;4153.608541138722;4176.874693759177;4088.9182216355803;4100.815463304143;4122.113745544707;4125.154343359619;4126.679462571979;3894.7078969077293;4069.9389509157386;4071.30787766079;4082.775447350409;4087.5912408759036;3979.9801000994953;4068.1863627274515;4088.3663032229756;4104.938425923614;4115.8971025724295;3645.8359373828243;3654.634536546351;3654.908627284339;3655.159313357916;3668.853245870162;5115.795368185305;5123.769430375642;5126.333576635051;5129.563987061104;5140.537351638371;4538.909221815578;4712;4716.504766999485;4732.95267047332;4749.1926372516755;5439.592030597721;5452.182172674091;5461.15352120422;5461.672299661993;5482.479164479368;3983.2431837950985;3984;4010.358342665189;4035.6771458283265;4079.265732168238;5454.672719636795;5549.99999999996;5588.944110558883;5667.518260947824;5714.771409143629;4106.301928672133;4114.465119534441;4119.567445418248;4122.464079669684;4137.110521237948;4160.604742549453;4177.97911010443;4180.247555439989;4183.6234738873645;4184.518780340239;4445.310976798602;4692.694974826693;4699.459562150328;4711.0449163597405;4735.052989402134;5439.156930675752;5458.536024437888;5462.863428414322;5464.153056276284;5476.288082549243;1444.487207041506;1452.5932738833144;1462.429652435551;1462.9487967921073;1465.4211586423303;927.8793756811706;951.191487235844;962.6438217859297;985.9499632890949;1017.6336518853207;5240.528352448222;5290.391604965402;5295.285136506523;5312.220406163901;5320.654157479751;5529.889402211933;5532.336119665666;5550.306211723535;5563.972180139154;5570.582206334541;5072.467390923974;5210.76551555181;5285.392179899284;5288.36539615241;5295.285136506599;2941.338198905229;2941.58817765513;2942.7640391035816;2945.749611283022;2947.381049979528;5704.372519022904;5710.685912274865;5721.141828725641;5748.626339287933;5763.85590360236;5544.500994910478;5662.207290979266;5668.404817494186;5692.829215123553;5706.771729130788;5706.258186435737;5714.885597308485;5728.885422291614;5746;5758.654480731169;5294.629375943647;5552.333719953632;5557.138643510262;5568.91646625309;5568.972155139199;5454.4545545445135;5488.121900495901;5499.202615620793;5507.586930980113;5530.364008139116;5692.601517893708;5704.144378343116;5725.255716756795;5800.970995145166;5818.389069147848;3994.2211268803467;4097.303458412018;4112.239235741397;4113.704183182408;4137.586241375839;5341.385740639721;5438.782448702008;5485.588580856532;5515.503604675599;5545;5483.835484935458;5492.1212605982855;5542.889142217214;5551;5552.584091056755;5394.919076213781;5420.674759514442;5424.566034717134;5433.538149257357;5438.015124479457;5235.293235413171;5445.782168713207;5467.480589344006;5514.91727624094;5518.972405137949;5468.726563671721;5487.314085739283;5505.201745746765;5514.6691198528215;5543.805966791143;5263.6578622389425;5409.972950135381;5426.918596220981;5431.2667789847865;5437.646552974044 04:33:50 INFO - PROCESS | 8618 | |5;yui.html;769.2461387839918;822.5681517203467;826.9958650206752;832.5961908474385;859.2395729779143;15207.695846083085;15984.680306393895;16328.75506867398;16360.672786544263;16767.83232167678;15392;15403.229838508058;15495.612609684764;15521.379144834193;15562.221888905566;663.4128796015513;801.2668408406302;814.2346194577108;835.5070508400042;841.0874201491389;823.555280148722;832.5004997001781;833.0836080311639;833.1085738260064;834.1241696218976;872.2411501993274;873.6418068591879;879.1955360844819;879.9340049496282;880.1682410122437;691.9031335613018;843.569779412498;869.4609342207808;876.5704804645742;876.9517676527788;598.2820615261703;599.8080614203457;624.4380057947883;625.6871564217892;625.9061140828867;15762.684746305009;15772.92113539425;15778.9211053944;15785.13181775002;15786.447474338343;15719.921400392925;15859.36562537497;15916.442924497704;15979.92010039954;16114.919425402915;12020.278783273032;12023.098267629963;12056.879431205663;12072;12283.14018018739;3811.599782022903;3843.5195600549932;3848.499695039655;3899.395593682984;3940.4089386591954;76008.61995690041;77294.61352693258;77514;78440.21559784387;79632.99999999942;11760.179096124228;11771.587994420153;11968.204769284677;12134.635960921187;12366.19619724715;20235.494112647302;20352.89823550873;20392.898035510025;20409.69385459219;20461.89769051145;9342.95328523353;9376.605882206175;9396.483193424427;9438.103380178873;9463.621455141854;5016.874578135576;5150.521609538003;5177.430482646906;5194.27280180775;5215.24378965048;3456.0668619473104;3553.8045407502836;3575.1598374382;3577.0878426001204;3583.9104022399647;624.643952946816;637.08260105448;638.4477427025682;638.8243233110932;640.8718256348749;713.8500914807948;725.5465334166146;725.5900416264899;733.7431898835365;735.0591243208702;9634.421934683942;9697.903020969841;9784.657536986171;9860.408375497493;10058.145057670034;666.0309250041179;680.5440354962187;739.0650826704224;742.1205871042831;750.6259364158144;4675.602573781199;4850.175470170079;4850.199717046718;4879.39007624047;4965.45380008206;118065;118866;119268.40365798115;121244;122214.38892805479;67119.66440167768;74928.62535687287;100221;100425.4936175958;100465;59479;86964.5651771737;91271;92106;92916.53541732248;9117.863232051392;9201.645274790782;9224.40041397307;9368.297377696565;9375.953120234355;50953.23570146377;52041.739791302316;52187;53557.46442535525;53717.731411344255;69629;70973.64513177401;80219;82506;82648;11528.59649912249;11542.826857596974;11562.248453850809;11643.948021463679;12007.519699211934;12808.743825123633;13083.280419576633;13391.330433478483;13398.665033374244;13867.306634668428;8174.386920980831;11783.469743861719;12449;12540.561080362144;12751.61745147647;12086.335251561248;12213.572524961584;12488.438020288928;12605.243685378906;12918.741625167257;11378.260413073123;11733.823992640288;11787.115966302734;12225;12588.496460141492;10851.837222441827;10887.564497420015;11093.472408147576;11253.66239012831;11292.322460652387;10788.568457261621;10879.292845964987;11053.226274160732;11106.666799996014;11171.329720216812 04:33:50 INFO - PROCESS | 8618 | __end_tp_report 04:33:50 INFO - PROCESS | 8618 | __start_cc_report 04:33:50 INFO - PROCESS | 8618 | _x_x_mozilla_cycle_collect,840 04:33:50 INFO - PROCESS | 8618 | __end_cc_report 04:33:50 INFO - PROCESS | 8618 | __startTimestamp1468064030987__endTimestamp 04:33:50 INFO - PROCESS | 8618 | 04:33:50 INFO - PROCESS | 8618 | ------- Summary: start ------- 04:33:50 INFO - PROCESS | 8618 | Number of tests: 6 04:33:50 INFO - PROCESS | 8618 | 04:33:50 INFO - PROCESS | 8618 | [#0] dojo.html Cycles:165 Average:5157.13 Median:5379.76 stddev:575.88 (10.7%) stddev-sans-first:552.20 04:33:50 INFO - PROCESS | 8618 | Values: 2999.3 3004.4 3041.1 3049.8 3054.8 5090.4 5151.5 5151.6 5260.6 5315.7 5158.6 5174.4 5179.6 5199.6 5236.1 4634.8 4734.8 4739.0 4795.7 4825.3 4703.7 4744.9 4759.6 4793.6 4806.3 4594.3 4655.7 4717.0 4717.2 4755.3 4712.0 4728.1 4742.3 4790.1 4837.9 4745.0 4756.5 4762.8 4774.7 4811.4 5067.2 5155.3 5222.2 5238.5 5243.1 5553.3 5560.1 5591.8 5591.9 5592.6 5376.7 5571.1 5612.9 5621.4 5624.0 5125.8 5177.4 5189.2 5240.1 5263.8 5699.2 5704.6 5744.5 5770.9 5772.0 5315.0 5351.8 5509.5 5513.6 5523.8 5496.1 5577.0 5582.7 5584.2 5589.2 5459.5 5491.1 5491.1 5495.8 5525.2 5316.7 5410.0 5452.5 5463.6 5468.6 4242.3 4245.8 4248.2 4282.6 4285.0 3798.7 3808.0 3810.1 3841.7 3848.5 5181.2 5218.8 5233.3 5283.0 5296.4 5537.0 5564.7 5568.1 5572.9 5616.0 5296.3 5307.0 5309.3 5319.9 5324.3 4622.1 4646.7 4661.6 4662.7 4673.7 5677.7 5682.1 5682.5 5687.3 5689.6 5428.6 5479.3 5479.9 5480.7 5526.3 5568.7 5643.9 5699.7 5728.3 5761.9 5429.1 5431.4 5443.5 5443.6 5446.5 5445.2 5502.7 5519.4 5527.1 5572.3 5367.3 5459.3 5478.7 5498.9 5505.1 5435.8 5441.8 5449.4 5452.8 5453.1 5291.7 5354.6 5386.4 5438.2 5497.4 5430.6 5498.1 5530.0 5531.1 5554.1 5379.8 5383.2 5396.1 5397.3 5400.3 04:33:50 INFO - PROCESS | 8618 | 04:33:50 INFO - PROCESS | 8618 | [#1] ext.html Cycles:180 Average:57793.32 Median:42201.18 stddev:108979.91 (258.2%) stddev-sans-first:109201.02 04:33:50 INFO - PROCESS | 8618 | Values: 596.7 616.2 633.6 633.7 634.3 32507.0 35794.6 35836.5 43178.4 44414.1 45208.3 45587.1 45736.1 45746.8 45811.0 8900.1 9047.4 9048.9 9052.9 9057.0 8957.9 9050.7 9057.3 9061.6 9062.5 9095.5 9147.9 9153.5 9162.1 9164.5 8972.8 9053.4 9079.0 9089.0 9092.2 8809.3 8809.9 8884.6 8890.6 8892.7 43186.0 43614.8 43694.6 43703.1 43717.9 3620.1 3687.3 3717.3 3819.6 4162.5 31071.2 31613.7 31776.5 31791.7 32314.2 4262.9 4365.8 4423.3 4493.3 4493.8 342154.0 343116.0 344425.0 345262.0 346536.0 57318.7 57510.0 57858.7 57878.4 57960.7 61534.4 61677.2 61877.0 61954.7 61984.0 16363.4 16614.8 16630.8 16642.4 16647.7 12934.5 12971.5 13003.3 13007.6 13013.5 15660.8 16671.7 16694.1 16727.2 16811.6 5654.3 5690.8 5749.2 5771.4 5879.9 1004.7 1010.7 1013.0 1073.0 1133.3 32848.2 33227.8 33293.8 33305.5 33713.2 1134.6 1140.2 1151.8 1164.3 1194.2 16821.2 17315.7 17493.5 17507.1 17538.6 501535.0 501754.0 503998.0 504618.5 504860.0 57850.7 57892.7 57971.0 58021.1 58097.1 1225.0 1335.6 1350.0 1390.6 1392.7 32949.8 33826.3 33962.3 34000.5 34095.3 49116.8 49841.3 49934.3 50012.0 50018.5 369472.0 371643.0 372531.0 374536.0 374862.0 34155.3 39309.4 40125.6 41290.0 44228.8 47935.0 49136.5 49348.0 49624.0 50178.0 39655.8 41379.6 41561.0 41843.4 42686.1 41614.8 41942.4 42100.4 42586.1 43097.4 41648.6 41716.0 42302.0 42438.4 42538.8 35044.9 36953.4 37247.6 37570.8 37588.0 28112.0 28181.7 28401.3 28415.4 28418.4 04:33:50 INFO - PROCESS | 8618 | 04:33:50 INFO - PROCESS | 8618 | [#2] jquery.html Cycles:180 Average:19989.59 Median:12693.33 stddev:33169.29 (261.3%) stddev-sans-first:33229.70 04:33:51 INFO - PROCESS | 8618 | Values: 392.8 397.6 401.7 404.0 418.1 13304.8 18459.4 19511.1 20137.9 20165.7 14323.0 17515.9 18140.9 19039.2 19446.7 5739.0 5901.2 5913.9 5935.6 5945.1 5815.0 5878.1 5883.7 5885.8 5897.6 4147.7 4334.4 5587.3 6433.7 6497.1 6299.1 6458.7 6640.8 6651.0 6653.7 5592.8 5614.4 5636.2 5638.8 5643.9 21823.2 23071.3 23207.4 23290.8 23312.4 2315.4 2394.5 2486.3 2663.3 2924.0 14062.6 14724.6 15037.2 15231.4 15410.6 1946.9 1963.6 1965.2 1994.6 2012.4 53279.2 53300.2 53705.7 83099.6 87719.1 11093.8 11213.1 11305.8 11385.3 11411.7 15340.6 15473.5 15541.5 15546.5 15572.5 7849.6 8019.5 8136.6 8139.6 8264.1 8030.5 8049.9 8136.0 8264.4 8274.8 4291.2 4384.3 4810.8 4819.7 4903.4 1821.8 1950.0 1957.4 1976.8 1987.0 926.7 982.5 1031.9 1046.0 1079.2 19274.2 19514.2 19679.5 19711.9 19998.6 980.0 985.2 1002.7 1006.3 1009.8 10777.1 10957.9 11008.9 11049.4 11069.3 180526.0 181872.0 182178.0 182494.0 184363.1 61091.7 64384.0 69669.7 85780.0 107564.0 982.6 989.4 1012.9 1024.0 1026.7 18020.5 18205.7 18460.3 18637.1 18836.4 32809.5 36816.0 43880.6 45100.8 46125.3 61614.4 62781.7 63472.4 63794.7 63838.7 8612.6 8873.2 8948.3 8977.7 9242.3 8975.9 13267.4 13563.0 13936.4 14146.6 12236.4 12281.4 12363.9 12465.4 12505.8 10695.8 12037.2 12118.8 12360.6 12470.2 12287.1 12610.1 12646.0 12663.7 12673.4 8786.6 9068.8 9070.9 9098.4 9144.7 11726.1 11903.6 11951.6 12038.8 12357.8 04:33:51 INFO - PROCESS | 8618 | 04:33:51 INFO - PROCESS | 8618 | [#3] mootools.html Cycles:180 Average:5636.87 Median:4570.57 stddev:3223.41 (70.5%) stddev-sans-first:3217.40 04:33:51 INFO - PROCESS | 8618 | Values: 1491.4 1505.5 1659.8 1747.3 1774.5 8171.6 8697.3 8720.4 8745.7 8794.3 7408.6 7580.2 7595.8 7853.0 8595.3 2185.6 2264.0 2290.7 2300.0 2303.9 2238.4 2263.4 2265.3 2282.6 2284.9 1779.9 2179.8 2255.8 2261.3 2262.0 2241.9 2291.9 2296.5 2300.5 2300.6 2189.9 2195.6 2205.1 2209.5 2236.3 8571.5 8680.7 8681.0 8684.4 8684.6 5019.1 5189.1 5192.0 5197.5 5203.5 3247.1 3360.3 3385.4 3420.3 3430.7 1014.0 1033.0 1046.4 1064.4 1068.3 11897.2 11932.9 11945.8 11950.9 11959.6 4282.6 4511.2 4550.5 4590.6 4593.4 10012.6 10036.0 10049.3 10051.5 10051.6 5089.8 5104.8 5116.5 5120.8 5127.5 3953.2 4463.2 4688.5 4697.9 4700.1 3871.2 3893.3 3947.4 3964.1 4007.1 1167.7 1173.1 1177.4 1183.7 1213.3 878.7 989.6 992.0 996.1 1008.1 5625.1 5645.5 5789.7 5802.8 5809.4 437.1 440.6 443.9 445.1 996.9 4046.1 4064.0 4075.8 4144.6 4146.2 10486.4 10645.9 10697.6 10711.3 10712.6 10454.7 10514.8 10563.6 10586.8 10655.4 7393.5 7724.4 7736.2 7921.4 7931.4 5656.8 6067.3 6138.8 6195.8 6300.5 9700.6 9846.5 9942.9 10040.5 10050.3 9849.6 10059.7 10166.3 10277.1 10314.5 7002.6 7830.2 7864.8 7998.3 8173.1 8264.0 8420.0 8474.5 8477.6 8481.2 7355.2 7433.3 7515.1 7592.1 7721.8 7203.6 7266.3 7342.3 7541.0 7568.7 6661.6 6699.0 6705.6 6715.4 6744.5 4976.2 5073.9 5152.9 5190.3 5211.2 4802.8 4863.1 4898.1 4899.6 4921.0 04:33:51 INFO - PROCESS | 8618 | 04:33:51 INFO - PROCESS | 8618 | [#4] prototype.html Cycles:180 Average:4616.66 Median:5282.35 stddev:1332.63 (25.2%) stddev-sans-first:1296.73 04:33:51 INFO - PROCESS | 8618 | Values: 318.1 320.0 326.3 328.6 329.5 5243.3 5269.9 5270.7 5272.3 5279.3 5181.2 5189.8 5218.6 5229.2 5229.5 3907.9 3982.2 4103.2 4153.6 4176.9 4088.9 4100.8 4122.1 4125.2 4126.7 3894.7 4069.9 4071.3 4082.8 4087.6 3980.0 4068.2 4088.4 4104.9 4115.9 3645.8 3654.6 3654.9 3655.2 3668.9 5115.8 5123.8 5126.3 5129.6 5140.5 4538.9 4712.0 4716.5 4733.0 4749.2 5439.6 5452.2 5461.2 5461.7 5482.5 3983.2 3984.0 4010.4 4035.7 4079.3 5454.7 5550.0 5588.9 5667.5 5714.8 4106.3 4114.5 4119.6 4122.5 4137.1 4160.6 4178.0 4180.2 4183.6 4184.5 4445.3 4692.7 4699.5 4711.0 4735.1 5439.2 5458.5 5462.9 5464.2 5476.3 1444.5 1452.6 1462.4 1462.9 1465.4 927.9 951.2 962.6 985.9 1017.6 5240.5 5290.4 5295.3 5312.2 5320.7 5529.9 5532.3 5550.3 5564.0 5570.6 5072.5 5210.8 5285.4 5288.4 5295.3 2941.3 2941.6 2942.8 2945.7 2947.4 5704.4 5710.7 5721.1 5748.6 5763.9 5544.5 5662.2 5668.4 5692.8 5706.8 5706.3 5714.9 5728.9 5746.0 5758.7 5294.6 5552.3 5557.1 5568.9 5569.0 5454.5 5488.1 5499.2 5507.6 5530.4 5692.6 5704.1 5725.3 5801.0 5818.4 3994.2 4097.3 4112.2 4113.7 4137.6 5341.4 5438.8 5485.6 5515.5 5545.0 5483.8 5492.1 5542.9 5551.0 5552.6 5394.9 5420.7 5424.6 5433.5 5438.0 5235.3 5445.8 5467.5 5514.9 5519.0 5468.7 5487.3 5505.2 5514.7 5543.8 5263.7 5410.0 5426.9 5431.3 5437.6 04:33:51 INFO - PROCESS | 8618 | 04:33:51 INFO - PROCESS | 8618 | [#5] yui.html Cycles:180 Average:20668.13 Median:4864.79 stddev:30007.79 (616.8%) stddev-sans-first:30054.77 04:33:51 INFO - PROCESS | 8618 | Values: 769.2 822.6 827.0 832.6 859.2 15207.7 15984.7 16328.8 16360.7 16767.8 15392.0 15403.2 15495.6 15521.4 15562.2 663.4 801.3 814.2 835.5 841.1 823.6 832.5 833.1 833.1 834.1 872.2 873.6 879.2 879.9 880.2 691.9 843.6 869.5 876.6 877.0 598.3 599.8 624.4 625.7 625.9 15762.7 15772.9 15778.9 15785.1 15786.4 15719.9 15859.4 15916.4 15979.9 16114.9 12020.3 12023.1 12056.9 12072.0 12283.1 3811.6 3843.5 3848.5 3899.4 3940.4 76008.6 77294.6 77514.0 78440.2 79633.0 11760.2 11771.6 11968.2 12134.6 12366.2 20235.5 20352.9 20392.9 20409.7 20461.9 9343.0 9376.6 9396.5 9438.1 9463.6 5016.9 5150.5 5177.4 5194.3 5215.2 3456.1 3553.8 3575.2 3577.1 3583.9 624.6 637.1 638.4 638.8 640.9 713.9 725.5 725.6 733.7 735.1 9634.4 9697.9 9784.7 9860.4 10058.1 666.0 680.5 739.1 742.1 750.6 4675.6 4850.2 4850.2 4879.4 4965.5 118065.0 118866.0 119268.4 121244.0 122214.4 67119.7 74928.6 100221.0 100425.5 100465.0 59479.0 86964.6 91271.0 92106.0 92916.5 9117.9 9201.6 9224.4 9368.3 9376.0 50953.2 52041.7 52187.0 53557.5 53717.7 69629.0 70973.6 80219.0 82506.0 82648.0 11528.6 11542.8 11562.2 11643.9 12007.5 12808.7 13083.3 13391.3 13398.7 13867.3 8174.4 11783.5 12449.0 12540.6 12751.6 12086.3 12213.6 12488.4 12605.2 12918.7 11378.3 11733.8 11787.1 12225.0 12588.5 10851.8 10887.6 11093.5 11253.7 11292.3 10788.6 10879.3 11053.2 11106.7 11171.3 04:33:51 INFO - PROCESS | 8618 | -------- Summary: end -------- 04:33:51 INFO - PROCESS | 8618 | 04:33:51 INFO - TEST-INFO | 8618: exit 0 04:33:51 INFO - TEST-OK | dromaeo_css | took 1112648ms 04:33:51 INFO - TEST-START | kraken 04:33:51 INFO - operating with platform_type : linux_ 04:33:51 INFO - Initialising browser for kraken test... 04:33:51 INFO - TEST-INFO | started process 8811 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZeaSPt/profile http://localhost:35259/getInfo.html) 04:33:55 INFO - PROCESS | 8811 | __metrics Screen width/height:1600/1200 04:33:55 INFO - PROCESS | 8811 | colorDepth:24 04:33:55 INFO - PROCESS | 8811 | Browser inner width/height: 1024/697 04:33:55 INFO - PROCESS | 8811 | __metrics 04:33:56 INFO - PROCESS | 8811 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:33:57 INFO - TEST-INFO | 8811: exit 0 04:33:57 INFO - Browser initialized. 04:33:57 INFO - Running cycle 1/1 for kraken test... 04:33:57 INFO - TEST-INFO | started process 8896 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZeaSPt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:34:09 INFO - PROCESS | 8896 | RSS: Main: 157810688 04:34:09 INFO - PROCESS | 8896 | 04:34:11 INFO - PROCESS | 8896 | Cycle 1(1): loaded http://localhost:35259/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35259/tests/kraken/driver.html?testName=audio-beat-detection) 04:34:12 INFO - PROCESS | 8896 | RSS: Main: 216748032 04:34:12 INFO - PROCESS | 8896 | 04:34:15 INFO - PROCESS | 8896 | Cycle 1(1): loaded http://localhost:35259/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35259/tests/kraken/driver.html?testName=audio-dft) 04:34:15 INFO - PROCESS | 8896 | RSS: Main: 203730944 04:34:15 INFO - PROCESS | 8896 | 04:34:18 INFO - PROCESS | 8896 | Cycle 1(1): loaded http://localhost:35259/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35259/tests/kraken/driver.html?testName=audio-fft) 04:34:19 INFO - PROCESS | 8896 | RSS: Main: 270184448 04:34:19 INFO - PROCESS | 8896 | 04:34:21 INFO - PROCESS | 8896 | Cycle 1(1): loaded http://localhost:35259/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35259/tests/kraken/driver.html?testName=audio-oscillator) 04:34:22 INFO - PROCESS | 8896 | RSS: Main: 179421184 04:34:22 INFO - PROCESS | 8896 | 04:34:24 INFO - PROCESS | 8896 | Cycle 1(1): loaded http://localhost:35259/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35259/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:34:24 INFO - PROCESS | 8896 | RSS: Main: 184832000 04:34:24 INFO - PROCESS | 8896 | 04:34:27 INFO - PROCESS | 8896 | Cycle 1(1): loaded http://localhost:35259/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35259/tests/kraken/driver.html?testName=imaging-darkroom) 04:34:28 INFO - PROCESS | 8896 | RSS: Main: 219463680 04:34:28 INFO - PROCESS | 8896 | 04:34:31 INFO - PROCESS | 8896 | Cycle 1(1): loaded http://localhost:35259/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35259/tests/kraken/driver.html?testName=imaging-desaturate) 04:34:32 INFO - PROCESS | 8896 | RSS: Main: 221437952 04:34:32 INFO - PROCESS | 8896 | 04:34:35 INFO - PROCESS | 8896 | Cycle 1(1): loaded http://localhost:35259/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35259/tests/kraken/driver.html?testName=json-parse-financial) 04:34:35 INFO - PROCESS | 8896 | RSS: Main: 221835264 04:34:35 INFO - PROCESS | 8896 | 04:34:37 INFO - PROCESS | 8896 | Cycle 1(1): loaded http://localhost:35259/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35259/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:34:37 INFO - PROCESS | 8896 | RSS: Main: 208257024 04:34:37 INFO - PROCESS | 8896 | 04:34:39 INFO - PROCESS | 8896 | Cycle 1(1): loaded http://localhost:35259/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35259/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:34:40 INFO - PROCESS | 8896 | RSS: Main: 211337216 04:34:40 INFO - PROCESS | 8896 | 04:34:42 INFO - PROCESS | 8896 | Cycle 1(1): loaded http://localhost:35259/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35259/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:34:43 INFO - PROCESS | 8896 | RSS: Main: 209854464 04:34:43 INFO - PROCESS | 8896 | 04:34:45 INFO - PROCESS | 8896 | Cycle 1(1): loaded http://localhost:35259/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35259/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:34:46 INFO - PROCESS | 8896 | RSS: Main: 226148352 04:34:46 INFO - PROCESS | 8896 | 04:34:48 INFO - PROCESS | 8896 | Cycle 1(1): loaded http://localhost:35259/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35259/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:34:49 INFO - PROCESS | 8896 | RSS: Main: 225296384 04:34:49 INFO - PROCESS | 8896 | 04:34:51 INFO - PROCESS | 8896 | Cycle 1(1): loaded http://localhost:35259/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35259/tests/kraken/driver.html?testName=ai-astar) 04:34:51 INFO - PROCESS | 8896 | RSS: Main: 267689984 04:34:51 INFO - PROCESS | 8896 | 04:34:51 INFO - PROCESS | 8896 | __start_tp_report 04:34:51 INFO - PROCESS | 8896 | _x_x_mozilla_page_load 04:34:51 INFO - PROCESS | 8896 | _x_x_mozilla_page_load_details 04:34:51 INFO - PROCESS | 8896 | |i|pagename|runs| 04:34:51 INFO - PROCESS | 8896 | |0;ai-astar;103;112;113;111;112;113;109;111;111;112 04:34:51 INFO - PROCESS | 8896 | |1;audio-beat-detection;153;117;122;177;121;117;147;121;146;125 04:34:51 INFO - PROCESS | 8896 | |2;audio-dft;161;160;161;160;160;160;162;161;161;161 04:34:51 INFO - PROCESS | 8896 | |3;audio-fft;75;74;74;118;75;77;74;75;106;74 04:34:51 INFO - PROCESS | 8896 | |4;audio-oscillator;84;85;108;84;84;84;119;84;85;137 04:34:51 INFO - PROCESS | 8896 | |5;imaging-gaussian-blur;117;117;117;118;116;116;116;117;116;116 04:34:51 INFO - PROCESS | 8896 | |6;imaging-darkroom;146;146;146;145;145;145;145;145;145;145 04:34:51 INFO - PROCESS | 8896 | |7;imaging-desaturate;96;96;95;96;95;95;95;95;95;95 04:34:51 INFO - PROCESS | 8896 | |8;json-parse-financial;51;52;54;53;52;54;56;53;53;53 04:34:51 INFO - PROCESS | 8896 | |9;json-stringify-tinderbox;62;62;62;62;64;63;63;62;63;63 04:34:51 INFO - PROCESS | 8896 | |10;stanford-crypto-aes;76;80;76;75;75;76;75;75;80;79 04:34:51 INFO - PROCESS | 8896 | |11;stanford-crypto-ccm;123;120;119;126;123;125;125;118;162;122 04:34:51 INFO - PROCESS | 8896 | |12;stanford-crypto-pbkdf2;158;157;158;161;156;158;154;156;154;156 04:34:51 INFO - PROCESS | 8896 | |13;stanford-crypto-sha256-iterative;65;63;67;65;63;65;65;64;62;66 04:34:51 INFO - PROCESS | 8896 | __end_tp_report 04:34:51 INFO - PROCESS | 8896 | __start_cc_report 04:34:51 INFO - PROCESS | 8896 | _x_x_mozilla_cycle_collect,1649 04:34:51 INFO - PROCESS | 8896 | __end_cc_report 04:34:51 INFO - PROCESS | 8896 | __startTimestamp1468064091376__endTimestamp 04:34:51 INFO - PROCESS | 8896 | 04:34:51 INFO - PROCESS | 8896 | ------- Summary: start ------- 04:34:51 INFO - PROCESS | 8896 | Number of tests: 14 04:34:51 INFO - PROCESS | 8896 | 04:34:51 INFO - PROCESS | 8896 | [#0] ai-astar Cycles:10 Average:110.70 Median:112.00 stddev:2.95 (2.6%) stddev-sans-first:1.24 04:34:51 INFO - PROCESS | 8896 | Values: 103.0 112.0 113.0 111.0 112.0 113.0 109.0 111.0 111.0 112.0 04:34:51 INFO - PROCESS | 8896 | 04:34:51 INFO - PROCESS | 8896 | [#1] audio-beat-detection Cycles:10 Average:134.60 Median:135.50 stddev:20.17 (14.9%) stddev-sans-first:20.26 04:34:51 INFO - PROCESS | 8896 | Values: 153.0 117.0 122.0 177.0 121.0 117.0 147.0 121.0 146.0 125.0 04:34:51 INFO - PROCESS | 8896 | 04:34:51 INFO - PROCESS | 8896 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.67 (0.4%) stddev-sans-first:0.71 04:34:51 INFO - PROCESS | 8896 | Values: 161.0 160.0 161.0 160.0 160.0 160.0 162.0 161.0 161.0 161.0 04:34:51 INFO - PROCESS | 8896 | 04:34:51 INFO - PROCESS | 8896 | [#3] audio-fft Cycles:10 Average:82.20 Median:74.50 stddev:15.98 (21.5%) stddev-sans-first:16.74 04:34:51 INFO - PROCESS | 8896 | Values: 75.0 74.0 74.0 118.0 75.0 77.0 74.0 75.0 106.0 74.0 04:34:51 INFO - PROCESS | 8896 | 04:34:51 INFO - PROCESS | 8896 | [#4] audio-oscillator Cycles:10 Average:95.40 Median:84.00 stddev:19.18 (22.8%) stddev-sans-first:19.90 04:34:51 INFO - PROCESS | 8896 | Values: 84.0 85.0 108.0 84.0 84.0 84.0 119.0 84.0 85.0 137.0 04:34:51 INFO - PROCESS | 8896 | 04:34:51 INFO - PROCESS | 8896 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 04:34:51 INFO - PROCESS | 8896 | Values: 117.0 117.0 117.0 118.0 116.0 116.0 116.0 117.0 116.0 116.0 04:34:51 INFO - PROCESS | 8896 | 04:34:51 INFO - PROCESS | 8896 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 04:34:51 INFO - PROCESS | 8896 | Values: 146.0 146.0 146.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 04:34:51 INFO - PROCESS | 8896 | 04:34:51 INFO - PROCESS | 8896 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 04:34:51 INFO - PROCESS | 8896 | Values: 96.0 96.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 04:34:51 INFO - PROCESS | 8896 | 04:34:51 INFO - PROCESS | 8896 | [#8] json-parse-financial Cycles:10 Average:53.10 Median:53.00 stddev:1.37 (2.6%) stddev-sans-first:1.22 04:34:51 INFO - PROCESS | 8896 | Values: 51.0 52.0 54.0 53.0 52.0 54.0 56.0 53.0 53.0 53.0 04:34:51 INFO - PROCESS | 8896 | 04:34:51 INFO - PROCESS | 8896 | [#9] json-stringify-tinderbox Cycles:10 Average:62.60 Median:63.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 04:34:51 INFO - PROCESS | 8896 | Values: 62.0 62.0 62.0 62.0 64.0 63.0 63.0 62.0 63.0 63.0 04:34:51 INFO - PROCESS | 8896 | 04:34:51 INFO - PROCESS | 8896 | [#10] stanford-crypto-aes Cycles:10 Average:76.70 Median:76.00 stddev:2.11 (2.8%) stddev-sans-first:2.22 04:34:51 INFO - PROCESS | 8896 | Values: 76.0 80.0 76.0 75.0 75.0 76.0 75.0 75.0 80.0 79.0 04:34:51 INFO - PROCESS | 8896 | 04:34:51 INFO - PROCESS | 8896 | [#11] stanford-crypto-ccm Cycles:10 Average:126.30 Median:124.00 stddev:12.82 (10.3%) stddev-sans-first:13.55 04:34:51 INFO - PROCESS | 8896 | Values: 123.0 120.0 119.0 126.0 123.0 125.0 125.0 118.0 162.0 122.0 04:34:51 INFO - PROCESS | 8896 | 04:34:51 INFO - PROCESS | 8896 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.80 Median:157.50 stddev:2.10 (1.3%) stddev-sans-first:2.18 04:34:51 INFO - PROCESS | 8896 | Values: 158.0 157.0 158.0 161.0 156.0 158.0 154.0 156.0 154.0 156.0 04:34:51 INFO - PROCESS | 8896 | 04:34:51 INFO - PROCESS | 8896 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.50 Median:65.00 stddev:1.51 (2.3%) stddev-sans-first:1.59 04:34:51 INFO - PROCESS | 8896 | Values: 65.0 63.0 67.0 65.0 63.0 65.0 65.0 64.0 62.0 66.0 04:34:51 INFO - PROCESS | 8896 | -------- Summary: end -------- 04:34:51 INFO - PROCESS | 8896 | 04:34:52 INFO - TEST-INFO | 8896: exit 0 04:34:52 INFO - TEST-OK | kraken | took 60586ms 04:34:52 INFO - SUITE-END | took 1173s 04:34:52 INFO - Completed test suite (00:19:33) 04:34:52 INFO - javascript benchmark 04:34:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2999.2501874531367, 3004.4291584598936, 3041.057272245603, 3049.7560195184387, 3054.755619550436, 5090.363704536933, 5151.536361727443, 5151.639385243035, 5260.579153667707, 5315.734213289335, 5158.638895277322, 5174.379074511055, 5179.585633149349, 5199.584033277338, 5236.1098613235745, 4634.8146074157075, 4734.786934587952, 4739.028499157665, 4795.688280261789, 4825.348577941968, 4703.670743047988, 4744.928826067612, 4759.571638552529, 4793.568578827905, 4806.279058141289, 4594.264917613183, 4655.674102812804, 4717.0, 4717.221658426355, 4755.334253204554, 4712.034033023222, 4728.148933192024, 4742.288656701522, 4790.113828941622, 4837.879053023667, 4744.976275118637, 4756.500567440438, 4762.809487620491, 4774.73738944358, 4811.350467686852, 5067.189249720064, 5155.278261043457, 5222.190560463135, 5238.476152384769, 5243.082460569385, 5553.333599967989, 5560.138178582286, 5591.832245032656, 5591.860203494904, 5592.5805564582415, 5376.650517716336, 5571.052921003439, 5612.915806262909, 5621.437856214387, 5623.971880140573, 5125.84622461323, 5177.430482646906, 5189.221616757516, 5240.056789777838, 5263.763130659129, 5699.202111704365, 5704.629199102045, 5744.4829965303325, 5770.88458230833, 5771.971140144273, 5314.97342513285, 5351.812686555952, 5509.5041446270025, 5513.61404701667, 5523.8066667666435, 5496.120620700749, 5577.024020796344, 5582.665040097607, 5584.162375643605, 5589.189567512688, 5459.481349271813, 5491.066518691752, 5491.121420572689, 5495.807646732425, 5525.171224316305, 5316.680999140064, 5409.972950135224, 5452.509274165344, 5463.617546771768, 5468.644538105011, 4242.321228603409, 4245.766482843474, 4248.171606536695, 4282.550332215073, 4285.0358669299785, 3798.6961043116485, 3808.0, 3810.0855794609092, 3841.7118716096406, 3848.499695039627, 5181.222816577543, 5218.817341393109, 5233.293505376725, 5282.97358513205, 5296.364436267672, 5536.972315138399, 5564.666120032811, 5568.1091025435735, 5572.860678482989, 5616.0, 5296.285001524822, 5306.973465132727, 5309.283246761715, 5319.867003324948, 5324.307839980777, 4622.144903192853, 4646.674732768742, 4661.627069834405, 4662.7202367858035, 4673.719576825401, 5677.659340439504, 5682.119271512922, 5682.545396368363, 5687.317521897481, 5689.601727879009, 5428.592855535771, 5479.2602998594675, 5479.945200547943, 5480.671159730429, 5526.253955715927, 5568.721563921868, 5643.858903527444, 5699.686517241592, 5728.283964504437, 5761.942380576308, 5429.131338985743, 5431.429699881455, 5443.455654434525, 5443.591730620298, 5446.509814116748, 5445.210444485607, 5502.697351645538, 5519.365272993497, 5527.078004160475, 5572.275604171432, 5367.329083864517, 5459.317585301837, 5478.726063696879, 5498.917516237339, 5505.119180931032, 5435.836924892102, 5441.755121019484, 5449.427810079885, 5452.781888724565, 5453.10023846061, 5291.682499050069, 5354.571634269327, 5386.434424385383, 5438.150888976517, 5497.367802702581, 5430.6198566101575, 5498.065328894178, 5530.032244357302, 5531.0873705838085, 5554.08357620988, 5379.757910893941, 5383.16560933056, 5396.1366181410785, 5397.325334333208, 5400.270963419888], "value": 5118.9089891491885, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [596.674812227336, 616.1866336435904, 633.5723386713967, 633.6736580660961, 634.2579182356642, 32507.0, 35794.642053579424, 35836.46245306319, 43178.35232471515, 44414.11171776563, 45208.321875171816, 45587.08825823481, 45736.08527829441, 45746.77126614362, 45811.0, 8900.109989001081, 9047.366684332066, 9048.864267036, 9052.8642070369, 9057.0, 8957.865632015524, 9050.683226087089, 9057.275417966546, 9061.592228349708, 9062.501562414065, 9095.499747513884, 9147.862782058275, 9153.535434330508, 9162.129597688208, 9164.450132992042, 8972.820543589158, 9053.366264361497, 9079.002619423716, 9088.954555227214, 9092.227160691316, 8809.251213646849, 8809.911900880974, 8884.644614215424, 8890.644374225023, 8892.688755893578, 43186.0, 43614.78192609049, 43694.56305436968, 43703.12593748139, 43717.9397442176, 3620.131168519563, 3687.2994131115, 3717.312297224995, 3819.618038196158, 4162.542120366757, 31071.223219419695, 31613.683863161536, 31776.523352149736, 31791.682083179105, 32314.192145196324, 4262.87211383659, 4365.781710914442, 4423.270160423526, 4493.303537951622, 4493.842715504941, 342154.0, 343116.0, 344425.0, 345262.0, 346536.0, 57318.713406432704, 57510.0, 57858.710706446196, 57878.42121578815, 57960.710196448745, 61534.38465615286, 61677.22452489649, 61877.0, 61954.69022654858, 61984.0, 16363.427280045142, 16614.83385166133, 16630.750538741686, 16642.417515386904, 16647.667046659, 12934.547290844775, 12971.545995890287, 13003.349832508336, 13007.609771706864, 13013.479460821462, 15660.765088523682, 16671.666566668842, 16694.08182549947, 16727.247273872705, 16811.57971050709, 5654.321481422174, 5690.829275121753, 5749.195112684228, 5771.422857714279, 5879.853003674943, 1004.6584161385164, 1010.7018429563296, 1012.9594816207417, 1072.978540429187, 1133.3143448213877, 32848.1787955303, 33227.83386083054, 33293.83353083268, 33305.50041749376, 33713.15717107092, 1134.5688638317552, 1140.201858698914, 1151.7523732397574, 1164.2956011612853, 1194.1819853400448, 16821.243044063045, 17315.740263896052, 17493.475195744148, 17507.124643767762, 17538.649227015645, 501535.0, 501754.0, 503998.0, 504618.4769076131, 504860.0, 57850.71074644684, 57892.71053644705, 57971.0, 58021.12968305479, 58097.128543071885, 1224.975500490003, 1335.6460537957448, 1349.9527516536873, 1390.610629023875, 1392.679683672761, 32949.83525082359, 33826.32347353089, 33962.320753585285, 34000.489992650626, 34095.31809363848, 49116.75441622769, 49841.25238121504, 49934.25098623451, 50012.0, 50018.49981500284, 369472.0, 371643.0, 372531.0, 374536.0, 374862.0, 34155.31689366149, 39309.41035884407, 40125.59874401218, 41290.0, 44228.798264164856, 47935.0, 49136.508634913196, 49348.0, 49624.0, 50178.0, 39655.80172099121, 41379.58620413757, 41561.0, 41843.37234941539, 42686.146277074906, 41614.791926040176, 41942.37086443767, 42100.36849447322, 42586.148277033666, 43097.35353969756, 41648.58351416447, 41716.0, 42302.0, 42438.36342454927, 42538.78730606327, 35044.85721820626, 36953.44569831508, 37247.6275237255, 37570.8121459391, 37588.0, 28112.0, 28181.71818281873, 28401.28996775097, 28415.43169136647, 28418.431631366842], "value": 20199.495871806987, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.75649097559517, 397.6282176165285, 401.6706300833318, 403.95758445363236, 418.09839712395967, 13304.800427993589, 18459.446216613505, 19511.121999510022, 20137.899310503446, 20165.697514537293, 14322.9895629224, 17515.91242043791, 18140.909295453537, 19039.238430462763, 19446.70829937552, 5738.99999999999, 5901.232839730829, 5913.852153696171, 5935.64386136831, 5945.137954996523, 5814.97092514539, 5878.059510478324, 5883.705814709268, 5885.764569417218, 5897.587168898179, 4147.668186545085, 4334.436523251973, 5587.329520457551, 6433.742650294006, 6497.090407342976, 6299.149614801989, 6458.741650333981, 6640.800775976729, 6651.035599838021, 6653.667316634149, 5592.832215033555, 5614.438556144394, 5636.15457681347, 5638.802641907555, 5643.8589035274035, 21823.236186733546, 23071.307860764206, 23207.419814504774, 23290.767092329028, 23312.417189570395, 2315.351701523576, 2394.5330660521204, 2486.27897909606, 2663.3208531824453, 2924.0496838527565, 14062.578122656336, 14724.55826325212, 15037.248137593077, 15231.390744370323, 15410.614734631725, 1946.9415917522497, 1963.5680150367039, 1965.2040923425893, 1994.5611965367596, 2012.3761633893394, 53279.20081198785, 53300.20049699258, 53705.731471342784, 83099.5845020777, 87719.12280877237, 11093.778124437466, 11213.10295176384, 11305.773884522263, 11385.316880987168, 11411.657650270505, 15340.616484587974, 15473.458428955159, 15541.456049038456, 15546.533603991898, 15572.454964076429, 7849.646765895548, 8019.518828870287, 8136.593170341459, 8139.552324622203, 8264.090949995496, 8030.478018928751, 8049.87925181111, 8135.959320203361, 8264.380171487162, 8274.751757447286, 4291.206126866539, 4384.276594361894, 4810.831620893252, 4819.7108173509705, 4903.387076615423, 1821.7624330051103, 1949.9902500487406, 1957.412776167144, 1976.7726711428081, 1987.0492318906413, 926.7405126564573, 982.474376208725, 1031.8916513766096, 1046.0480962324248, 1079.228351728518, 19274.22903083861, 19514.219431222875, 19679.50801229952, 19711.901440492707, 19998.600027999357, 980.0, 985.2069084386994, 1002.734275417015, 1006.2905651515664, 1009.8333774927055, 10777.137828973664, 10957.945210274058, 11008.889911100947, 11049.447527623586, 11069.335839849635, 180526.0, 181872.0, 182178.0, 182494.0, 184363.07818460822, 61091.69454152701, 64384.0, 69669.65165174243, 85780.0, 107564.0, 982.6020461713018, 989.3766926836047, 1012.8581998520214, 1023.9641612543376, 1026.712520494263, 18020.54948626295, 18205.726914096034, 18460.26158953627, 18637.068146592344, 18836.434906952814, 32809.50785738263, 36816.0, 43880.56119438765, 45100.77449612731, 46125.30812037889, 61614.383856160865, 62781.68609156925, 63472.36527634849, 63794.68102659457, 63838.68080659567, 8612.569371531523, 8873.245774109273, 8948.284137269133, 8977.685780997634, 9242.306826988137, 8975.910240897507, 13267.40296686632, 13563.0, 13936.372863220977, 14146.575602731935, 12236.388180591113, 12281.447334869774, 12363.876361236273, 12465.439055242718, 12505.812412813997, 10695.786084278427, 12037.157398981988, 12118.818217726564, 12360.629181124581, 12470.189437686522, 12287.078469115031, 12610.117291789487, 12646.0, 12663.683407914876, 12673.366331683195, 8786.604602793017, 9068.773280668036, 9070.863937041082, 9098.36311458218, 9144.679936202201, 11726.120540959633, 11903.583374582195, 11951.641450756491, 12038.75922481528, 12357.814632780335], "value": 9119.789792187903, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1491.433255362962, 1505.5031839492967, 1659.8257182995785, 1747.3272789975856, 1774.5297496163519, 8171.550564718938, 8697.347698922575, 8720.389572729911, 8745.693900713477, 8794.296456283499, 7408.5554866708035, 7580.1661817200065, 7595.77212683619, 7853.0, 8595.269402100814, 2185.595664802013, 2263.9660405093937, 2290.6793048973072, 2300.0, 2303.873286969216, 2238.418011317061, 2263.411513006614, 2265.2864347730497, 2282.611955967481, 2284.942876428094, 1779.9199036043344, 2179.7711240319777, 2255.7744225577394, 2261.276391554695, 2262.0, 2241.8879056047213, 2291.942701432469, 2296.5292115116363, 2300.459392042869, 2300.6318988961852, 2189.901454434554, 2195.6157672407426, 2205.1289740552393, 2209.4807720185904, 2236.2955668964387, 8571.528565928871, 8680.6527738891, 8681.0, 8684.39209255346, 8684.565771711452, 5019.071471777733, 5189.065968125736, 5192.039472697563, 5197.532222100029, 5203.453637368098, 3247.1395080303737, 3360.311136217094, 3385.4244778387733, 3420.2817408344276, 3430.6740859618294, 1014.0467960117466, 1032.9948350258276, 1046.3721766939852, 1064.356064580925, 1068.2522234435849, 11897.167198296209, 11932.940335298355, 11945.820812687729, 11950.880491195063, 11959.581414650445, 4282.614564689193, 4511.233090374579, 4550.49944506104, 4590.632749380042, 4593.448786145617, 10012.649557265606, 10036.0, 10049.296549241482, 10051.49742512886, 10051.64819231338, 5089.821856235014, 5104.795808167632, 5116.462771409023, 5120.820771272987, 5127.4872512748425, 3953.150072734376, 4463.196624607602, 4688.507706690816, 4697.859064228079, 4700.130475861976, 3871.2257548490416, 3893.3381325174787, 3947.407888816643, 3964.0882597002274, 4007.0583412897945, 1167.6788883057056, 1173.0791328807015, 1177.4289469607234, 1183.7040739815047, 1213.2720367779261, 878.7100256915203, 989.618996686281, 991.980160396788, 996.0836030851634, 1008.1481148429565, 5625.071863142617, 5645.491905728422, 5789.681567513743, 5802.796902108406, 5809.390014048464, 437.093031958687, 440.583648452216, 443.94894587122246, 445.10311721880436, 996.9401835889724, 4046.109855831712, 4064.0, 4075.7962101895378, 4144.626983571493, 4146.170765846843, 10486.37081775096, 10645.893541064645, 10697.625583104555, 10711.303765255234, 10712.571497140027, 10454.738631534272, 10514.789704205874, 10563.577456901792, 10586.841197382046, 10655.413952232546, 7393.519421237603, 7724.382049436032, 7736.187700291501, 7921.405894557816, 7931.405144614177, 5656.830295091154, 6067.271927368567, 6138.815835524942, 6195.81412557624, 6300.495960323255, 9700.563474643517, 9846.458444785605, 9942.900570994198, 10040.497975101362, 10050.346727462691, 9849.556769945226, 10059.748506287402, 10166.288359814742, 10277.075063244343, 10314.535845886803, 7002.614856182959, 7830.177831327628, 7864.84270314602, 7998.280154786097, 8173.141820108803, 8263.95868020656, 8420.031696354752, 8474.533900635524, 8477.576121193792, 8481.194286542768, 7355.1541572719825, 7433.331000210007, 7515.098188217449, 7592.126905405949, 7721.7683469496005, 7203.639818009184, 7266.309700578437, 7342.302481264272, 7541.0, 7568.697252109854, 6661.633610151294, 6698.966505167443, 6705.631190284581, 6715.3620406061345, 6744.460443164437, 4976.2286845539, 5073.898522029613, 5152.896942061213, 5190.299309593308, 5211.166213405837, 4802.807887684593, 4863.124637565131, 4898.069366820293, 4899.632527560376, 4920.975395123001], "value": 4455.473250867574, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.14736506163484, 319.99360012799747, 326.3424200236522, 328.5892634207241, 329.4777777223101, 5243.344581927259, 5269.920951185735, 5270.683758974455, 5272.340957380327, 5279.313689220406, 5181.222816577515, 5189.8183563575285, 5218.634695571312, 5229.2156176573535, 5229.50319719627, 3907.902302442433, 3982.1637456134245, 4103.199876024177, 4153.608541138722, 4176.874693759177, 4088.9182216355803, 4100.815463304143, 4122.113745544707, 4125.154343359619, 4126.679462571979, 3894.7078969077293, 4069.9389509157386, 4071.30787766079, 4082.775447350409, 4087.5912408759036, 3979.9801000994953, 4068.1863627274515, 4088.3663032229756, 4104.938425923614, 4115.8971025724295, 3645.8359373828243, 3654.634536546351, 3654.908627284339, 3655.159313357916, 3668.853245870162, 5115.795368185305, 5123.769430375642, 5126.333576635051, 5129.563987061104, 5140.537351638371, 4538.909221815578, 4712.0, 4716.504766999485, 4732.95267047332, 4749.1926372516755, 5439.592030597721, 5452.182172674091, 5461.15352120422, 5461.672299661993, 5482.479164479368, 3983.2431837950985, 3984.0, 4010.358342665189, 4035.6771458283265, 4079.265732168238, 5454.672719636795, 5549.99999999996, 5588.944110558883, 5667.518260947824, 5714.771409143629, 4106.301928672133, 4114.465119534441, 4119.567445418248, 4122.464079669684, 4137.110521237948, 4160.604742549453, 4177.97911010443, 4180.247555439989, 4183.6234738873645, 4184.518780340239, 4445.310976798602, 4692.694974826693, 4699.459562150328, 4711.0449163597405, 4735.052989402134, 5439.156930675752, 5458.536024437888, 5462.863428414322, 5464.153056276284, 5476.288082549243, 1444.487207041506, 1452.5932738833144, 1462.429652435551, 1462.9487967921073, 1465.4211586423303, 927.8793756811706, 951.191487235844, 962.6438217859297, 985.9499632890949, 1017.6336518853207, 5240.528352448222, 5290.391604965402, 5295.285136506523, 5312.220406163901, 5320.654157479751, 5529.889402211933, 5532.336119665666, 5550.306211723535, 5563.972180139154, 5570.582206334541, 5072.467390923974, 5210.76551555181, 5285.392179899284, 5288.36539615241, 5295.285136506599, 2941.338198905229, 2941.58817765513, 2942.7640391035816, 2945.749611283022, 2947.381049979528, 5704.372519022904, 5710.685912274865, 5721.141828725641, 5748.626339287933, 5763.85590360236, 5544.500994910478, 5662.207290979266, 5668.404817494186, 5692.829215123553, 5706.771729130788, 5706.258186435737, 5714.885597308485, 5728.885422291614, 5746.0, 5758.654480731169, 5294.629375943647, 5552.333719953632, 5557.138643510262, 5568.91646625309, 5568.972155139199, 5454.4545545445135, 5488.121900495901, 5499.202615620793, 5507.586930980113, 5530.364008139116, 5692.601517893708, 5704.144378343116, 5725.255716756795, 5800.970995145166, 5818.389069147848, 3994.2211268803467, 4097.303458412018, 4112.239235741397, 4113.704183182408, 4137.586241375839, 5341.385740639721, 5438.782448702008, 5485.588580856532, 5515.503604675599, 5545.0, 5483.835484935458, 5492.1212605982855, 5542.889142217214, 5551.0, 5552.584091056755, 5394.919076213781, 5420.674759514442, 5424.566034717134, 5433.538149257357, 5438.015124479457, 5235.293235413171, 5445.782168713207, 5467.480589344006, 5514.91727624094, 5518.972405137949, 5468.726563671721, 5487.314085739283, 5505.201745746765, 5514.6691198528215, 5543.805966791143, 5263.6578622389425, 5409.972950135381, 5426.918596220981, 5431.2667789847865, 5437.646552974044], "value": 4193.566499712027, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [769.2461387839918, 822.5681517203467, 826.9958650206752, 832.5961908474385, 859.2395729779143, 15207.695846083085, 15984.680306393895, 16328.75506867398, 16360.672786544263, 16767.83232167678, 15392.0, 15403.229838508058, 15495.612609684764, 15521.379144834193, 15562.221888905566, 663.4128796015513, 801.2668408406302, 814.2346194577108, 835.5070508400042, 841.0874201491389, 823.555280148722, 832.5004997001781, 833.0836080311639, 833.1085738260064, 834.1241696218976, 872.2411501993274, 873.6418068591879, 879.1955360844819, 879.9340049496282, 880.1682410122437, 691.9031335613018, 843.569779412498, 869.4609342207808, 876.5704804645742, 876.9517676527788, 598.2820615261703, 599.8080614203457, 624.4380057947883, 625.6871564217892, 625.9061140828867, 15762.684746305009, 15772.92113539425, 15778.9211053944, 15785.13181775002, 15786.447474338343, 15719.921400392925, 15859.36562537497, 15916.442924497704, 15979.92010039954, 16114.919425402915, 12020.278783273032, 12023.098267629963, 12056.879431205663, 12072.0, 12283.14018018739, 3811.599782022903, 3843.5195600549932, 3848.499695039655, 3899.395593682984, 3940.4089386591954, 76008.61995690041, 77294.61352693258, 77514.0, 78440.21559784387, 79632.99999999942, 11760.179096124228, 11771.587994420153, 11968.204769284677, 12134.635960921187, 12366.19619724715, 20235.494112647302, 20352.89823550873, 20392.898035510025, 20409.69385459219, 20461.89769051145, 9342.95328523353, 9376.605882206175, 9396.483193424427, 9438.103380178873, 9463.621455141854, 5016.874578135576, 5150.521609538003, 5177.430482646906, 5194.27280180775, 5215.24378965048, 3456.0668619473104, 3553.8045407502836, 3575.1598374382, 3577.0878426001204, 3583.9104022399647, 624.643952946816, 637.08260105448, 638.4477427025682, 638.8243233110932, 640.8718256348749, 713.8500914807948, 725.5465334166146, 725.5900416264899, 733.7431898835365, 735.0591243208702, 9634.421934683942, 9697.903020969841, 9784.657536986171, 9860.408375497493, 10058.145057670034, 666.0309250041179, 680.5440354962187, 739.0650826704224, 742.1205871042831, 750.6259364158144, 4675.602573781199, 4850.175470170079, 4850.199717046718, 4879.39007624047, 4965.45380008206, 118065.0, 118866.0, 119268.40365798115, 121244.0, 122214.38892805479, 67119.66440167768, 74928.62535687287, 100221.0, 100425.4936175958, 100465.0, 59479.0, 86964.5651771737, 91271.0, 92106.0, 92916.53541732248, 9117.863232051392, 9201.645274790782, 9224.40041397307, 9368.297377696565, 9375.953120234355, 50953.23570146377, 52041.739791302316, 52187.0, 53557.46442535525, 53717.731411344255, 69629.0, 70973.64513177401, 80219.0, 82506.0, 82648.0, 11528.59649912249, 11542.826857596974, 11562.248453850809, 11643.948021463679, 12007.519699211934, 12808.743825123633, 13083.280419576633, 13391.330433478483, 13398.665033374244, 13867.306634668428, 8174.386920980831, 11783.469743861719, 12449.0, 12540.561080362144, 12751.61745147647, 12086.335251561248, 12213.572524961584, 12488.438020288928, 12605.243685378906, 12918.741625167257, 11378.260413073123, 11733.823992640288, 11787.115966302734, 12225.0, 12588.496460141492, 10851.837222441827, 10887.564497420015, 11093.472408147576, 11253.66239012831, 11292.322460652387, 10788.568457261621, 10879.292845964987, 11053.226274160732, 11106.666799996014, 11171.329720216812], "value": 7549.914972130839, "unit": "score"}], "name": "dromaeo_css", "value": 7144.881022571521, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 113.0, 111.0, 112.0, 113.0, 109.0, 111.0, 111.0, 112.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 117.0, 122.0, 177.0, 121.0, 117.0, 147.0, 121.0, 146.0, 125.0], "value": 134.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 160.0, 160.0, 160.0, 162.0, 161.0, 161.0, 161.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 74.0, 118.0, 75.0, 77.0, 74.0, 75.0, 106.0, 74.0], "value": 82.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 108.0, 84.0, 84.0, 84.0, 119.0, 84.0, 85.0, 137.0], "value": 95.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 116.0, 116.0, 116.0, 117.0, 116.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0], "value": 145.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 52.0, 54.0, 53.0, 52.0, 54.0, 56.0, 53.0, 53.0, 53.0], "value": 53.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 62.0, 64.0, 63.0, 63.0, 62.0, 63.0, 63.0], "value": 62.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 80.0, 76.0, 75.0, 75.0, 76.0, 75.0, 75.0, 80.0, 79.0], "value": 76.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 120.0, 119.0, 126.0, 123.0, 125.0, 125.0, 118.0, 162.0, 122.0], "value": 126.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 157.0, 158.0, 161.0, 156.0, 158.0, 154.0, 156.0, 154.0, 156.0], "value": 156.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 67.0, 65.0, 63.0, 65.0, 65.0, 64.0, 62.0, 66.0], "value": 64.5, "unit": "score"}], "name": "kraken", "value": 1480.8, "alertThreshold": 2.0}]} 04:34:52 INFO - Return code: 0 04:34:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:34:52 INFO - # TBPL SUCCESS # 04:34:52 INFO - Running post-action listener: _resource_record_post_action 04:34:52 INFO - ##### 04:34:52 INFO - ##### Finished run-tests step (success) 04:34:52 INFO - ##### 04:34:52 INFO - Running post-run listener: _resource_record_post_run 04:34:52 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 12288; Write bytes: 553099264; Read time: 456; Write time: 585980 04:34:52 INFO - TinderboxPrint: CPU usage
13.0% 04:34:52 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 456 04:34:52 INFO - TinderboxPrint: I/O write bytes / time
553,099,264 / 585,980 04:34:52 INFO - TinderboxPrint: CPU idle
8,269.3 (87.0%) 04:34:52 INFO - TinderboxPrint: CPU user
1,193.9 (12.6%) 04:34:52 INFO - TinderboxPrint: Swap in / out
0 / 0 04:34:52 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 4096; Write bytes: 256585728; Read time: 196; Write time: 307668 04:34:52 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 296333312; Read time: 248; Write time: 278288 04:34:53 INFO - Running post-run listener: _upload_blobber_files 04:34:53 INFO - Blob upload gear active. 04:34:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:34:53 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 04:34:53 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', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:34:53 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 Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:34:53 INFO - (blobuploader) - INFO - Open directory for files ... 04:34:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:34:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:34:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:34:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:34:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:34:54 INFO - (blobuploader) - INFO - Done attempting. 04:34:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:34:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:34:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:34:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:34:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:34:55 INFO - (blobuploader) - INFO - Done attempting. 04:34:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:34:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:34:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:34:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:34:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:34:58 INFO - (blobuploader) - INFO - Done attempting. 04:34:58 INFO - (blobuploader) - INFO - Iteration through files over. 04:34:58 INFO - Return code: 0 04:34:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:34:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:34:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/628499250c58d55910e8c653a9846ed4eedd9c2a7bf781293c55ed62b4f2ae56682545b90a6df5b49fad20d0d9903b351e563c3c71e592f82f893776a6c4fc9c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/99a2f8900eebe3119c125266cbfa65fd6e85f3e01739c4b717601fa873b58c7dea428a2073aa805a66fbeb77d03afab9be69178c44ed55fbca900d6d01bd5f68", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1d205b62a83faeea40b6da6f6a981144fb6285373c818276082313b4c928d5ce45c5fe6ec5de4230a04c819d984966ed798bbf7bf6a44758a0080f9d5d7b73a5"} 04:34:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:34:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:34:58 INFO - Contents: 04:34:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/628499250c58d55910e8c653a9846ed4eedd9c2a7bf781293c55ed62b4f2ae56682545b90a6df5b49fad20d0d9903b351e563c3c71e592f82f893776a6c4fc9c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/99a2f8900eebe3119c125266cbfa65fd6e85f3e01739c4b717601fa873b58c7dea428a2073aa805a66fbeb77d03afab9be69178c44ed55fbca900d6d01bd5f68", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1d205b62a83faeea40b6da6f6a981144fb6285373c818276082313b4c928d5ce45c5fe6ec5de4230a04c819d984966ed798bbf7bf6a44758a0080f9d5d7b73a5"} 04:34:58 INFO - Running post-run listener: copy_logs_to_upload_dir 04:34:58 INFO - Copying logs to upload dir... 04:34:58 INFO - mkdir: /builds/slave/test/build/upload/logs 04:34:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.812554 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-07-09 04:34:58.244796) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-09 04:34:58.248631) ========= 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=c6927cf182745ad25b1d38b9000001fe-1468061246.213790-1438631038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/628499250c58d55910e8c653a9846ed4eedd9c2a7bf781293c55ed62b4f2ae56682545b90a6df5b49fad20d0d9903b351e563c3c71e592f82f893776a6c4fc9c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/99a2f8900eebe3119c125266cbfa65fd6e85f3e01739c4b717601fa873b58c7dea428a2073aa805a66fbeb77d03afab9be69178c44ed55fbca900d6d01bd5f68", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1d205b62a83faeea40b6da6f6a981144fb6285373c818276082313b4c928d5ce45c5fe6ec5de4230a04c819d984966ed798bbf7bf6a44758a0080f9d5d7b73a5"} build_url:https://queue.taskcluster.net/v1/task/WbUEBQaJTtGR5NhfPmTf9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011281 build_url: 'https://queue.taskcluster.net/v1/task/WbUEBQaJTtGR5NhfPmTf9g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/628499250c58d55910e8c653a9846ed4eedd9c2a7bf781293c55ed62b4f2ae56682545b90a6df5b49fad20d0d9903b351e563c3c71e592f82f893776a6c4fc9c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/99a2f8900eebe3119c125266cbfa65fd6e85f3e01739c4b717601fa873b58c7dea428a2073aa805a66fbeb77d03afab9be69178c44ed55fbca900d6d01bd5f68", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1d205b62a83faeea40b6da6f6a981144fb6285373c818276082313b4c928d5ce45c5fe6ec5de4230a04c819d984966ed798bbf7bf6a44758a0080f9d5d7b73a5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-09 04:34:58.275622) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 04:34:58.275933) ========= 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=c6927cf182745ad25b1d38b9000001fe-1468061246.213790-1438631038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004539 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 04:34:58.355081) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-09 04:34:58.355405) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-09 04:34:58.355700) ========= ========= Total master_lag: 0.17 =========