builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-002 starttime: 1468842384.92 results: success (0) buildid: 20160718013034 builduid: c3835165731c47c88ef94688b744dc59 revision: c8ba6a6eec22033228aad26f08db5ac4ff129461 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 04:46:24.919939) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 04:46:24.920417) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 04:46:24.920703) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 04:46:24.932865) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 04:46:24.933160) ========= 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=a0d2d2de893abaa8702a9954000001a7-1468842384.90743-1060770222 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-18 04:46:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 88.9M=0s 2016-07-18 04:46:25 (88.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125097 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 04:46:25.069727) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 04:46:25.070034) ========= 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=a0d2d2de893abaa8702a9954000001a7-1468842384.90743-1060770222 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017344 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 04:46:25.119068) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 04:46:25.119419) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev c8ba6a6eec22033228aad26f08db5ac4ff129461 --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 c8ba6a6eec22033228aad26f08db5ac4ff129461 --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=a0d2d2de893abaa8702a9954000001a7-1468842384.90743-1060770222 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-18 04:46:25,203 truncating revision to first 12 chars 2016-07-18 04:46:25,203 Setting DEBUG logging. 2016-07-18 04:46:25,203 attempt 1/10 2016-07-18 04:46:25,203 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/c8ba6a6eec22?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-18 04:46:25,515 unpacking tar archive at: mozilla-inbound-c8ba6a6eec22/testing/mozharness/ program finished with exit code 0 elapsedTime=0.647290 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 04:46:25.780147) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 04:46:25.780480) ========= script_repo_revision: c8ba6a6eec22033228aad26f08db5ac4ff129461 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 04:46:25.781233) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 04:46:25.781992) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 04:46:25.794894) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-07-18 04:46:25.795553) ========= /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=a0d2d2de893abaa8702a9954000001a7-1468842384.90743-1060770222 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:46:25 INFO - MultiFileLogger online at 20160718 04:46:25 in /builds/slave/test 04:46:25 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:46:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:46:25 INFO - {'append_to_log': False, 04:46:25 INFO - 'base_work_dir': '/builds/slave/test', 04:46:25 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 04:46:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:46:25 INFO - 'branch': 'Mozilla-Inbound', 04:46:25 INFO - 'buildbot_json_path': 'buildprops.json', 04:46:25 INFO - 'config_files': ('talos/linux_config.py',), 04:46:25 INFO - 'default_actions': ('clobber', 04:46:25 INFO - 'read-buildbot-config', 04:46:25 INFO - 'download-and-extract', 04:46:25 INFO - 'populate-webroot', 04:46:25 INFO - 'create-virtualenv', 04:46:25 INFO - 'install', 04:46:25 INFO - 'run-tests'), 04:46:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:46:25 INFO - 'download_minidump_stackwalk': True, 04:46:25 INFO - 'download_symbols': 'ondemand', 04:46:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:46:25 INFO - 'tooltool.py': '/tools/tooltool.py', 04:46:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:46:25 INFO - '/tools/misc-python/virtualenv.py')}, 04:46:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:46:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:46:25 INFO - 'installer_path': 'installer.exe', 04:46:25 INFO - 'log_level': 'info', 04:46:25 INFO - 'log_name': 'talos', 04:46:25 INFO - 'log_to_console': True, 04:46:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:46:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:46:25 INFO - 'opt_config_files': (), 04:46:25 INFO - 'pip_index': False, 04:46:25 INFO - 'sps_profile': False, 04:46:25 INFO - 'sps_profile_interval': 0, 04:46:25 INFO - 'suite': 'dromaeojs', 04:46:25 INFO - 'system_bits': '32', 04:46:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:46:25 INFO - 'title': 'talos-linux64-ix-002', 04:46:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:46:25 INFO - 'use_talos_json': True, 04:46:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:46:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:46:25 INFO - 'work_dir': 'build'} 04:46:25 INFO - ##### 04:46:25 INFO - ##### Running clobber step. 04:46:25 INFO - ##### 04:46:25 INFO - Running pre-action listener: _resource_record_pre_action 04:46:25 INFO - Running main action method: clobber 04:46:25 INFO - rmtree: /builds/slave/test/build 04:46:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:46:26 INFO - Running post-action listener: _resource_record_post_action 04:46:26 INFO - ##### 04:46:26 INFO - ##### Finished clobber step (success) 04:46:26 INFO - ##### 04:46:26 INFO - ##### 04:46:26 INFO - ##### Running read-buildbot-config step. 04:46:26 INFO - ##### 04:46:26 INFO - Running pre-action listener: _resource_record_pre_action 04:46:26 INFO - Running main action method: read_buildbot_config 04:46:26 INFO - Using buildbot properties: 04:46:26 INFO - { 04:46:26 INFO - "project": "", 04:46:26 INFO - "product": "firefox", 04:46:26 INFO - "script_repo_revision": "production", 04:46:26 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 04:46:26 INFO - "repository": "", 04:46:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 04:46:26 INFO - "buildid": "20160718013034", 04:46:26 INFO - "pgo_build": "True", 04:46:26 INFO - "basedir": "/builds/slave/test", 04:46:26 INFO - "buildnumber": 1257, 04:46:26 INFO - "slavename": "talos-linux64-ix-002", 04:46:26 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:46:26 INFO - "platform": "ubuntu64_hw", 04:46:26 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 04:46:26 INFO - "branch": "mozilla-inbound", 04:46:26 INFO - "repo_path": "integration/mozilla-inbound", 04:46:26 INFO - "revision": "c8ba6a6eec22033228aad26f08db5ac4ff129461", 04:46:26 INFO - "stage_platform": "linux64-pgo", 04:46:26 INFO - "builduid": "c3835165731c47c88ef94688b744dc59", 04:46:26 INFO - "slavebuilddir": "test" 04:46:26 INFO - } 04:46:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/DRsE8QyhQp-Diue66PX13g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 04:46:26 INFO - Running post-action listener: _resource_record_post_action 04:46:26 INFO - ##### 04:46:26 INFO - ##### Finished read-buildbot-config step (success) 04:46:26 INFO - ##### 04:46:26 INFO - ##### 04:46:26 INFO - ##### Running download-and-extract step. 04:46:26 INFO - ##### 04:46:26 INFO - Running pre-action listener: _resource_record_pre_action 04:46:26 INFO - Running main action method: download_and_extract 04:46:26 INFO - mkdir: /builds/slave/test/build/tests 04:46:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:46:26 INFO - https://queue.taskcluster.net/v1/task/DRsE8QyhQp-Diue66PX13g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:46:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRsE8QyhQp-Diue66PX13g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:46:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRsE8QyhQp-Diue66PX13g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:46:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRsE8QyhQp-Diue66PX13g/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:46:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRsE8QyhQp-Diue66PX13g/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:46:27 INFO - Downloaded 1361 bytes. 04:46:27 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:46:27 INFO - Using the following test package requirements: 04:46:27 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:46:27 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:46:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:46:27 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:46:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:46:27 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:46:27 INFO - u'jsshell-linux-x86_64.zip'], 04:46:27 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:46:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:46:27 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:46:27 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:46:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:46:27 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:46:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:46:27 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:46:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:46:27 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:46:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:46:27 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:46: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:46:27 INFO - https://queue.taskcluster.net/v1/task/DRsE8QyhQp-Diue66PX13g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:46:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRsE8QyhQp-Diue66PX13g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:46:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRsE8QyhQp-Diue66PX13g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:46:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRsE8QyhQp-Diue66PX13g/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:46:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRsE8QyhQp-Diue66PX13g/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:46:28 INFO - Downloaded 24334383 bytes. 04:46:28 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:46:28 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:46:29 INFO - Return code: 0 04:46:29 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:46:29 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:46:29 INFO - https://queue.taskcluster.net/v1/task/DRsE8QyhQp-Diue66PX13g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:46:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRsE8QyhQp-Diue66PX13g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:46:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRsE8QyhQp-Diue66PX13g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:46:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRsE8QyhQp-Diue66PX13g/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:46:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRsE8QyhQp-Diue66PX13g/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:46:30 INFO - Downloaded 24334383 bytes. 04:46:30 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:46:30 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:46:32 INFO - Return code: 0 04:46:32 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:46:32 INFO - https://queue.taskcluster.net/v1/task/DRsE8QyhQp-Diue66PX13g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:46:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRsE8QyhQp-Diue66PX13g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:46:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRsE8QyhQp-Diue66PX13g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:46:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRsE8QyhQp-Diue66PX13g/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:46:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRsE8QyhQp-Diue66PX13g/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:46:33 INFO - Downloaded 14403317 bytes. 04:46:33 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:46:33 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:46:33 INFO - Return code: 0 04:46: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:46:33 INFO - https://queue.taskcluster.net/v1/task/DRsE8QyhQp-Diue66PX13g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:46:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRsE8QyhQp-Diue66PX13g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:46:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRsE8QyhQp-Diue66PX13g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:46:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRsE8QyhQp-Diue66PX13g/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:46:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRsE8QyhQp-Diue66PX13g/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:46:34 INFO - Downloaded 60834016 bytes. 04:46:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DRsE8QyhQp-Diue66PX13g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:46:34 INFO - mkdir: /builds/slave/test/properties 04:46:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:46:34 INFO - Writing to file /builds/slave/test/properties/build_url 04:46:34 INFO - Contents: 04:46:34 INFO - build_url:https://queue.taskcluster.net/v1/task/DRsE8QyhQp-Diue66PX13g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:46:35 INFO - Running post-action listener: _resource_record_post_action 04:46:35 INFO - Running post-action listener: set_extra_try_arguments 04:46:35 INFO - ##### 04:46:35 INFO - ##### Finished download-and-extract step (success) 04:46:35 INFO - ##### 04:46:35 INFO - ##### 04:46:35 INFO - ##### Running populate-webroot step. 04:46:35 INFO - ##### 04:46:35 INFO - Running pre-action listener: _resource_record_pre_action 04:46:35 INFO - Running main action method: populate_webroot 04:46:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:46:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:46:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:46:35 INFO - '--tppagecycles', 04:46:35 INFO - '7'], 04:46:35 INFO - 'tests': ['tsvgm']}}, 04:46:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:46:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:46:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:46:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:46:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:46:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:46:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:46:35 INFO - 'talos_options': ['--disable-e10s'], 04:46:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:46:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:46:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:46:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:46:35 INFO - 'talos_options': ['--disable-e10s'], 04:46:35 INFO - 'tests': ['damp', 'tps']}, 04:46:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:46:35 INFO - 'tests': ['damp', 'tps']}, 04:46:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:46:35 INFO - 'tests': ['dromaeo_dom']}, 04:46:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:46:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:46:35 INFO - 'tests': ['basic_compositor_video']}, 04:46:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:46:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:46:35 INFO - 'tests': ['a11yr', 04:46:35 INFO - 'ts_paint', 04:46:35 INFO - 'tpaint', 04:46:35 INFO - 'sessionrestore', 04:46:35 INFO - 'sessionrestore_no_auto_restore', 04:46:35 INFO - 'tabpaint']}, 04:46:35 INFO - 'other-e10s': {'tests': ['a11yr', 04:46:35 INFO - 'ts_paint', 04:46:35 INFO - 'tpaint', 04:46:35 INFO - 'sessionrestore', 04:46:35 INFO - 'sessionrestore_no_auto_restore', 04:46:35 INFO - 'tabpaint']}, 04:46:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:46:35 INFO - 'ts_paint', 04:46:35 INFO - 'tpaint', 04:46:35 INFO - 'sessionrestore', 04:46:35 INFO - 'sessionrestore_no_auto_restore', 04:46:35 INFO - 'tabpaint']}, 04:46:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:46:35 INFO - 'ts_paint', 04:46:35 INFO - 'tpaint', 04:46:35 INFO - 'sessionrestore', 04:46:35 INFO - 'sessionrestore_no_auto_restore', 04:46:35 INFO - 'tabpaint']}, 04:46:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:46:35 INFO - 'tests': ['a11yr', 04:46:35 INFO - 'ts_paint', 04:46:35 INFO - 'tpaint', 04:46:35 INFO - 'sessionrestore', 04:46:35 INFO - 'sessionrestore_no_auto_restore', 04:46:35 INFO - 'tabpaint']}, 04:46:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:46:35 INFO - 'tests': ['a11yr', 04:46:35 INFO - 'ts_paint', 04:46:35 INFO - 'tpaint', 04:46:35 INFO - 'sessionrestore', 04:46:35 INFO - 'sessionrestore_no_auto_restore', 04:46:35 INFO - 'tabpaint']}, 04:46:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:46:35 INFO - 'tests': ['tsvgx', 04:46:35 INFO - 'tsvgr_opacity', 04:46:35 INFO - 'tart', 04:46:35 INFO - 'tscrollx', 04:46:35 INFO - 'cart']}, 04:46:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:46:35 INFO - 'tsvgr_opacity', 04:46:35 INFO - 'tart', 04:46:35 INFO - 'tscrollx', 04:46:35 INFO - 'cart']}, 04:46:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:46:35 INFO - 'talos_options': ['--disable-e10s'], 04:46:35 INFO - 'tests': ['tp5o']}, 04:46:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:46:35 INFO - 'tests': ['tp5o']}, 04:46:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:46:35 INFO - 'talos_options': ['--disable-e10s', 04:46:35 INFO - '--xperf_path', 04:46:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:46:35 INFO - 'tests': ['tp5n']}, 04:46:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:46:35 INFO - 'talos_options': ['--xperf_path', 04:46:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:46:35 INFO - 'tests': ['tp5n']}}, 04:46:35 INFO - 'talos.zip': {'path': '', 04:46:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:46:35 INFO - Running post-action listener: _resource_record_post_action 04:46:35 INFO - ##### 04:46:35 INFO - ##### Finished populate-webroot step (success) 04:46:35 INFO - ##### 04:46:35 INFO - ##### 04:46:35 INFO - ##### Running create-virtualenv step. 04:46:35 INFO - ##### 04:46:35 INFO - Running pre-action listener: _resource_record_pre_action 04:46:35 INFO - Running main action method: create_virtualenv 04:46:35 INFO - Creating virtualenv /builds/slave/test/build/venv 04:46:35 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:46:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:46:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:46:35 INFO - Using real prefix '/usr' 04:46:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:46:36 INFO - Installing distribute.............................................................................................................................................................................................done. 04:46:38 INFO - Installing pip.................done. 04:46:38 INFO - Return code: 0 04:46:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:46:38 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:46:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:38 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:46:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:38 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 0x127b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153a3b0>, '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 0x153b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x153b740>, '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': 'a0d2d2de893abaa8702a9954000001a7-1468842384.90743-1060770222', '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:46:38 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:46:38 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:46:38 INFO - Using env: {'DISPLAY': ':0', 04:46:38 INFO - 'HOME': '/home/cltbld', 04:46:38 INFO - 'LANG': 'en_US.UTF-8', 04:46:38 INFO - 'LANGUAGE': 'en_US:en', 04:46:38 INFO - 'LOGNAME': 'cltbld', 04:46:38 INFO - 'MAIL': '/var/mail/cltbld', 04:46:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:38 INFO - 'MOZ_NO_REMOTE': '1', 04:46:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:38 INFO - 'NO_EM_RESTART': '1', 04:46:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:38 INFO - 'PWD': '/builds/slave/test', 04:46:38 INFO - 'SHELL': '/bin/bash', 04:46:38 INFO - 'SHLVL': '1', 04:46:38 INFO - 'TERM': 'linux', 04:46:38 INFO - 'TMOUT': '86400', 04:46:38 INFO - 'USER': 'cltbld', 04:46:38 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1468842384.90743-1060770222', 04:46:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:38 INFO - '_': '/tools/buildbot/bin/python'} 04:46:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:38 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:46:38 INFO - Cleaning up... 04:46:38 INFO - Return code: 0 04:46:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:46:38 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:46:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:38 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:46:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:38 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 0x127b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153a3b0>, '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 0x153b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x153b740>, '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': 'a0d2d2de893abaa8702a9954000001a7-1468842384.90743-1060770222', '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:46:38 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:46:38 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:46:38 INFO - Using env: {'DISPLAY': ':0', 04:46:38 INFO - 'HOME': '/home/cltbld', 04:46:38 INFO - 'LANG': 'en_US.UTF-8', 04:46:38 INFO - 'LANGUAGE': 'en_US:en', 04:46:38 INFO - 'LOGNAME': 'cltbld', 04:46:38 INFO - 'MAIL': '/var/mail/cltbld', 04:46:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:38 INFO - 'MOZ_NO_REMOTE': '1', 04:46:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:38 INFO - 'NO_EM_RESTART': '1', 04:46:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:38 INFO - 'PWD': '/builds/slave/test', 04:46:38 INFO - 'SHELL': '/bin/bash', 04:46:38 INFO - 'SHLVL': '1', 04:46:38 INFO - 'TERM': 'linux', 04:46:38 INFO - 'TMOUT': '86400', 04:46:38 INFO - 'USER': 'cltbld', 04:46:38 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1468842384.90743-1060770222', 04:46:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:38 INFO - '_': '/tools/buildbot/bin/python'} 04:46:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:38 INFO - Downloading/unpacking psutil>=3.1.1 04:46:38 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:46:38 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:46:38 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:46:38 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:46:38 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:46:38 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:46:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:46:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:46:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:46:40 INFO - Installing collected packages: psutil 04:46:40 INFO - Running setup.py install for psutil 04:46:40 INFO - building 'psutil._psutil_linux' extension 04:46:40 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:46:40 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:46:40 INFO - building 'psutil._psutil_posix' extension 04:46:40 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:46:40 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:46:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:46:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:46:40 INFO - Successfully installed psutil 04:46:40 INFO - Cleaning up... 04:46:41 INFO - Return code: 0 04:46:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:46:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:41 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 0x127b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153a3b0>, '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 0x153b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x153b740>, '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': 'a0d2d2de893abaa8702a9954000001a7-1468842384.90743-1060770222', '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:46:41 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:46:41 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:46:41 INFO - Using env: {'DISPLAY': ':0', 04:46:41 INFO - 'HOME': '/home/cltbld', 04:46:41 INFO - 'LANG': 'en_US.UTF-8', 04:46:41 INFO - 'LANGUAGE': 'en_US:en', 04:46:41 INFO - 'LOGNAME': 'cltbld', 04:46:41 INFO - 'MAIL': '/var/mail/cltbld', 04:46:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:41 INFO - 'MOZ_NO_REMOTE': '1', 04:46:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:41 INFO - 'NO_EM_RESTART': '1', 04:46:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:41 INFO - 'PWD': '/builds/slave/test', 04:46:41 INFO - 'SHELL': '/bin/bash', 04:46:41 INFO - 'SHLVL': '1', 04:46:41 INFO - 'TERM': 'linux', 04:46:41 INFO - 'TMOUT': '86400', 04:46:41 INFO - 'USER': 'cltbld', 04:46:41 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1468842384.90743-1060770222', 04:46:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:41 INFO - '_': '/tools/buildbot/bin/python'} 04:46:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:46:41 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:46:41 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:46:41 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:46:41 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:46:41 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:46:41 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:46:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:46:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:46:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:46:43 INFO - Installing collected packages: mozsystemmonitor 04:46:43 INFO - Running setup.py install for mozsystemmonitor 04:46:43 INFO - Successfully installed mozsystemmonitor 04:46:43 INFO - Cleaning up... 04:46:43 INFO - Return code: 0 04:46:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:46:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:43 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 0x127b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153a3b0>, '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 0x153b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x153b740>, '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': 'a0d2d2de893abaa8702a9954000001a7-1468842384.90743-1060770222', '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:46:43 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:46:43 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:46:43 INFO - Using env: {'DISPLAY': ':0', 04:46:43 INFO - 'HOME': '/home/cltbld', 04:46:43 INFO - 'LANG': 'en_US.UTF-8', 04:46:43 INFO - 'LANGUAGE': 'en_US:en', 04:46:43 INFO - 'LOGNAME': 'cltbld', 04:46:43 INFO - 'MAIL': '/var/mail/cltbld', 04:46:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:43 INFO - 'MOZ_NO_REMOTE': '1', 04:46:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:43 INFO - 'NO_EM_RESTART': '1', 04:46:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:43 INFO - 'PWD': '/builds/slave/test', 04:46:43 INFO - 'SHELL': '/bin/bash', 04:46:43 INFO - 'SHLVL': '1', 04:46:43 INFO - 'TERM': 'linux', 04:46:43 INFO - 'TMOUT': '86400', 04:46:43 INFO - 'USER': 'cltbld', 04:46:43 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1468842384.90743-1060770222', 04:46:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:43 INFO - '_': '/tools/buildbot/bin/python'} 04:46:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:43 INFO - Downloading/unpacking jsonschema==2.5.1 04:46:43 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:46:43 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:46:43 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:46:43 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:46:43 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:46:43 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:46:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:46:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:46: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:46: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:46: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:46: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:46: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:46: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:46:45 INFO - Downloading functools32-3.2.3-2.tar.gz 04:46:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:46:45 INFO - warning: no files found matching '*.txt' 04:46:45 INFO - no previously-included directories found matching 'build' 04:46:45 INFO - no previously-included directories found matching 'dist' 04:46:45 INFO - no previously-included directories found matching '.git*' 04:46:45 INFO - Installing collected packages: jsonschema, functools32 04:46:45 INFO - Running setup.py install for functools32 04:46:45 INFO - warning: no files found matching '*.txt' 04:46:45 INFO - no previously-included directories found matching 'build' 04:46:45 INFO - no previously-included directories found matching 'dist' 04:46:45 INFO - no previously-included directories found matching '.git*' 04:46:45 INFO - Successfully installed jsonschema functools32 04:46:45 INFO - Cleaning up... 04:46:45 INFO - Return code: 0 04:46:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:46: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:46:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46: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:46:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46: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', '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 0x127b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153a3b0>, '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 0x153b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x153b740>, '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': 'a0d2d2de893abaa8702a9954000001a7-1468842384.90743-1060770222', '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:46: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:46: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 blobuploader==1.2.4 04:46:45 INFO - Using env: {'DISPLAY': ':0', 04:46:45 INFO - 'HOME': '/home/cltbld', 04:46:45 INFO - 'LANG': 'en_US.UTF-8', 04:46:45 INFO - 'LANGUAGE': 'en_US:en', 04:46:45 INFO - 'LOGNAME': 'cltbld', 04:46:45 INFO - 'MAIL': '/var/mail/cltbld', 04:46:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:45 INFO - 'MOZ_NO_REMOTE': '1', 04:46:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:45 INFO - 'NO_EM_RESTART': '1', 04:46:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:45 INFO - 'PWD': '/builds/slave/test', 04:46:45 INFO - 'SHELL': '/bin/bash', 04:46:45 INFO - 'SHLVL': '1', 04:46:45 INFO - 'TERM': 'linux', 04:46:45 INFO - 'TMOUT': '86400', 04:46:45 INFO - 'USER': 'cltbld', 04:46:45 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1468842384.90743-1060770222', 04:46:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:45 INFO - '_': '/tools/buildbot/bin/python'} 04:46:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:46 INFO - Downloading/unpacking blobuploader==1.2.4 04:46:46 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:46:46 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:46:46 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:46:46 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:46:46 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:46:46 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:46:48 INFO - Downloading blobuploader-1.2.4.tar.gz 04:46:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:46:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:46: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:46: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:46: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:46: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:46: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:46: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:46:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:46:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:46: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:46: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:46: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:46: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:46: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:46: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:46:48 INFO - Downloading docopt-0.6.1.tar.gz 04:46:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:46:48 INFO - Installing collected packages: blobuploader, requests, docopt 04:46:48 INFO - Running setup.py install for blobuploader 04:46:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:46:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:46:48 INFO - Running setup.py install for requests 04:46:49 INFO - Running setup.py install for docopt 04:46:49 INFO - Successfully installed blobuploader requests docopt 04:46:49 INFO - Cleaning up... 04:46:49 INFO - Return code: 0 04:46:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:46:49 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:46:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:49 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:46:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:49 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 0x127b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153a3b0>, '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 0x153b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x153b740>, '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': 'a0d2d2de893abaa8702a9954000001a7-1468842384.90743-1060770222', '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:46:49 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:46:49 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:46:49 INFO - Using env: {'DISPLAY': ':0', 04:46:49 INFO - 'HOME': '/home/cltbld', 04:46:49 INFO - 'LANG': 'en_US.UTF-8', 04:46:49 INFO - 'LANGUAGE': 'en_US:en', 04:46:49 INFO - 'LOGNAME': 'cltbld', 04:46:49 INFO - 'MAIL': '/var/mail/cltbld', 04:46:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:49 INFO - 'MOZ_NO_REMOTE': '1', 04:46:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:49 INFO - 'NO_EM_RESTART': '1', 04:46:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:49 INFO - 'PWD': '/builds/slave/test', 04:46:49 INFO - 'SHELL': '/bin/bash', 04:46:49 INFO - 'SHLVL': '1', 04:46:49 INFO - 'TERM': 'linux', 04:46:49 INFO - 'TMOUT': '86400', 04:46:49 INFO - 'USER': 'cltbld', 04:46:49 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1468842384.90743-1060770222', 04:46:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:49 INFO - '_': '/tools/buildbot/bin/python'} 04:46:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:46:49 INFO - Running setup.py (path:/tmp/pip-2RK5Vf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:46:49 INFO - Running setup.py (path:/tmp/pip-ite2EH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:46:49 INFO - Running setup.py (path:/tmp/pip-b6UCLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:46:49 INFO - Running setup.py (path:/tmp/pip-J9lJuC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:46:49 INFO - Running setup.py (path:/tmp/pip-C_kyZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:46:50 INFO - Running setup.py (path:/tmp/pip-_GnNYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:46:50 INFO - Running setup.py (path:/tmp/pip-0tlzY0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:46:50 INFO - Running setup.py (path:/tmp/pip-rFl3C1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:46:50 INFO - Running setup.py (path:/tmp/pip-tuWFsD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:46:50 INFO - Running setup.py (path:/tmp/pip-8wVJjG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:46:50 INFO - Running setup.py (path:/tmp/pip-QL4ZqT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:46:50 INFO - Running setup.py (path:/tmp/pip-IF3tQZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:46:50 INFO - Running setup.py (path:/tmp/pip-4iv_9N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:46:50 INFO - Running setup.py (path:/tmp/pip-nTiAvw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:46:50 INFO - Running setup.py (path:/tmp/pip-tTSSTb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:46:50 INFO - Running setup.py (path:/tmp/pip-xVNLow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:46:50 INFO - Running setup.py (path:/tmp/pip-Gc2_pU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:46:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:46:50 INFO - Running setup.py install for manifestparser 04:46:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:46:51 INFO - Running setup.py install for mozcrash 04:46:51 INFO - Running setup.py install for mozdebug 04:46:51 INFO - Running setup.py install for mozdevice 04:46:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:46:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:46:51 INFO - Running setup.py install for mozfile 04:46:51 INFO - Running setup.py install for mozhttpd 04:46:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:46:51 INFO - Running setup.py install for mozinfo 04:46:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:46:51 INFO - Running setup.py install for mozInstall 04:46:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:46:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:46:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:46:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:46:51 INFO - Running setup.py install for mozleak 04:46:51 INFO - Running setup.py install for mozlog 04:46:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:46:51 INFO - Running setup.py install for moznetwork 04:46:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:46:52 INFO - Running setup.py install for mozprocess 04:46:52 INFO - Running setup.py install for mozprofile 04:46:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:46:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:46:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:46:52 INFO - Running setup.py install for mozrunner 04:46:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:46:52 INFO - Running setup.py install for mozscreenshot 04:46:52 INFO - Running setup.py install for moztest 04:46:52 INFO - Running setup.py install for mozversion 04:46:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:46:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:46:52 INFO - Cleaning up... 04:46:52 INFO - Return code: 0 04:46:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:46:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:52 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 0x127b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153a3b0>, '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 0x153b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x153b740>, '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': 'a0d2d2de893abaa8702a9954000001a7-1468842384.90743-1060770222', '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:46:52 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:46:52 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:46:52 INFO - Using env: {'DISPLAY': ':0', 04:46:52 INFO - 'HOME': '/home/cltbld', 04:46:52 INFO - 'LANG': 'en_US.UTF-8', 04:46:52 INFO - 'LANGUAGE': 'en_US:en', 04:46:52 INFO - 'LOGNAME': 'cltbld', 04:46:52 INFO - 'MAIL': '/var/mail/cltbld', 04:46:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:52 INFO - 'MOZ_NO_REMOTE': '1', 04:46:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:52 INFO - 'NO_EM_RESTART': '1', 04:46:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:52 INFO - 'PWD': '/builds/slave/test', 04:46:52 INFO - 'SHELL': '/bin/bash', 04:46:52 INFO - 'SHLVL': '1', 04:46:52 INFO - 'TERM': 'linux', 04:46:52 INFO - 'TMOUT': '86400', 04:46:52 INFO - 'USER': 'cltbld', 04:46:52 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1468842384.90743-1060770222', 04:46:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:52 INFO - '_': '/tools/buildbot/bin/python'} 04:46:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:46:52 INFO - Running setup.py (path:/tmp/pip-sXDrX6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:46:52 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:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:46:52 INFO - Running setup.py (path:/tmp/pip-RlP_A6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:46:53 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:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:46:53 INFO - Running setup.py (path:/tmp/pip-LMjwNR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:46:53 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:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:46:53 INFO - Running setup.py (path:/tmp/pip-xgi8kw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:46:53 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:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:46:53 INFO - Running setup.py (path:/tmp/pip-hUnsjf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:46:53 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:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:46:53 INFO - Running setup.py (path:/tmp/pip-1go3OR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:46:53 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:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:46:53 INFO - Running setup.py (path:/tmp/pip-ilN4ph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:46:53 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:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:46:53 INFO - Running setup.py (path:/tmp/pip-z5TBRU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:46:53 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:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:46:53 INFO - Running setup.py (path:/tmp/pip-yRXr78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:46:53 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:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:46:53 INFO - Running setup.py (path:/tmp/pip-LPLZTk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:46:53 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:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:46:53 INFO - Running setup.py (path:/tmp/pip-1PebMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:46:53 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:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:46:53 INFO - Running setup.py (path:/tmp/pip-Tc_UsM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:46:53 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:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:46:53 INFO - Running setup.py (path:/tmp/pip-750x8j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:46:53 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:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:46:53 INFO - Running setup.py (path:/tmp/pip-BNxETg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:46:53 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:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:46:53 INFO - Running setup.py (path:/tmp/pip-QHgdMn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:46:54 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:46:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:46:54 INFO - Running setup.py (path:/tmp/pip-R8vbCm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:46:54 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:46:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:46:54 INFO - Running setup.py (path:/tmp/pip-ul7j4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:46:54 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:46:54 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:46:54 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:46:54 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:46:54 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:46:54 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:46:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:46:54 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:46:54 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:46:54 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:46:54 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:46:54 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:46:54 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:46:56 INFO - Downloading blessings-1.6.tar.gz 04:46:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:46:56 INFO - Installing collected packages: blessings 04:46:56 INFO - Running setup.py install for blessings 04:46:56 INFO - Successfully installed blessings 04:46:56 INFO - Cleaning up... 04:46:56 INFO - Return code: 0 04:46:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:46:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:46:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:46:56 INFO - Reading from file tmpfile_stdout 04:46:56 INFO - Current package versions: 04:46:56 INFO - argparse == 1.2.1 04:46:56 INFO - blessings == 1.6 04:46:56 INFO - blobuploader == 1.2.4 04:46:56 INFO - docopt == 0.6.1 04:46:56 INFO - functools32 == 3.2.3-2 04:46:56 INFO - jsonschema == 2.5.1 04:46:56 INFO - manifestparser == 1.1 04:46:56 INFO - mozInstall == 1.12 04:46:56 INFO - mozcrash == 0.17 04:46:56 INFO - mozdebug == 0.1 04:46:56 INFO - mozdevice == 0.48 04:46:56 INFO - mozfile == 1.2 04:46:56 INFO - mozhttpd == 0.7 04:46:56 INFO - mozinfo == 0.9 04:46:56 INFO - mozleak == 0.1 04:46:56 INFO - mozlog == 3.2 04:46:56 INFO - moznetwork == 0.27 04:46:56 INFO - mozprocess == 0.23 04:46:56 INFO - mozprofile == 0.28 04:46:56 INFO - mozrunner == 6.12 04:46:56 INFO - mozscreenshot == 0.1 04:46:56 INFO - mozsystemmonitor == 0.3 04:46:56 INFO - moztest == 0.7 04:46:56 INFO - mozversion == 1.4 04:46:56 INFO - psutil == 3.1.1 04:46:56 INFO - requests == 1.2.3 04:46:56 INFO - wsgiref == 0.1.2 04:46:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:46:56 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:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:56 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:46:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:56 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 0x127b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153a3b0>, '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 0x153b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x153b740>, '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': 'a0d2d2de893abaa8702a9954000001a7-1468842384.90743-1060770222', '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:46:56 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:46:56 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:46:56 INFO - Using env: {'DISPLAY': ':0', 04:46:56 INFO - 'HOME': '/home/cltbld', 04:46:56 INFO - 'LANG': 'en_US.UTF-8', 04:46:56 INFO - 'LANGUAGE': 'en_US:en', 04:46:56 INFO - 'LOGNAME': 'cltbld', 04:46:56 INFO - 'MAIL': '/var/mail/cltbld', 04:46:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:56 INFO - 'MOZ_NO_REMOTE': '1', 04:46:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:56 INFO - 'NO_EM_RESTART': '1', 04:46:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:56 INFO - 'PWD': '/builds/slave/test', 04:46:56 INFO - 'SHELL': '/bin/bash', 04:46:56 INFO - 'SHLVL': '1', 04:46:56 INFO - 'TERM': 'linux', 04:46:56 INFO - 'TMOUT': '86400', 04:46:56 INFO - 'USER': 'cltbld', 04:46:56 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1468842384.90743-1060770222', 04:46:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:56 INFO - '_': '/tools/buildbot/bin/python'} 04:46:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:56 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:46:56 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:46:56 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:46:56 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:46:56 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:46:56 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:46:56 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:46:56 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:46:56 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:46:56 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:46:56 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:46:56 INFO - Cleaning up... 04:46:56 INFO - Return code: 0 04:46:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:46:56 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:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:56 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:46:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:56 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 0x127b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153a3b0>, '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 0x153b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x153b740>, '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': 'a0d2d2de893abaa8702a9954000001a7-1468842384.90743-1060770222', '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:46:56 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:46:56 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:46:56 INFO - Using env: {'DISPLAY': ':0', 04:46:56 INFO - 'HOME': '/home/cltbld', 04:46:56 INFO - 'LANG': 'en_US.UTF-8', 04:46:56 INFO - 'LANGUAGE': 'en_US:en', 04:46:56 INFO - 'LOGNAME': 'cltbld', 04:46:56 INFO - 'MAIL': '/var/mail/cltbld', 04:46:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:56 INFO - 'MOZ_NO_REMOTE': '1', 04:46:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:56 INFO - 'NO_EM_RESTART': '1', 04:46:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:56 INFO - 'PWD': '/builds/slave/test', 04:46:56 INFO - 'SHELL': '/bin/bash', 04:46:56 INFO - 'SHLVL': '1', 04:46:56 INFO - 'TERM': 'linux', 04:46:56 INFO - 'TMOUT': '86400', 04:46:56 INFO - 'USER': 'cltbld', 04:46:56 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1468842384.90743-1060770222', 04:46:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:56 INFO - '_': '/tools/buildbot/bin/python'} 04:46:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:46:56 INFO - Cleaning up... 04:46:56 INFO - Return code: 0 04:46:56 INFO - Running post-action listener: _resource_record_post_action 04:46:56 INFO - Running post-action listener: _start_resource_monitoring 04:46:56 INFO - Starting resource monitoring. 04:46:56 INFO - ##### 04:46:56 INFO - ##### Finished create-virtualenv step (success) 04:46:56 INFO - ##### 04:46:56 INFO - ##### 04:46:56 INFO - ##### Running install step. 04:46:56 INFO - ##### 04:46:56 INFO - Running pre-action listener: _resource_record_pre_action 04:46:56 INFO - Running main action method: install 04:46:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:46:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:46:57 INFO - Reading from file tmpfile_stdout 04:46:57 INFO - Detecting whether we're running mozinstall >=1.0... 04:46:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:46:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:46:57 INFO - Reading from file tmpfile_stdout 04:46:57 INFO - Output received: 04:46:57 INFO - Usage: mozinstall [options] installer 04:46:57 INFO - Options: 04:46:57 INFO - -h, --help show this help message and exit 04:46:57 INFO - -d DEST, --destination=DEST 04:46:57 INFO - Directory to install application into. [default: 04:46:57 INFO - "/builds/slave/test"] 04:46:57 INFO - --app=APP Application being installed. [default: firefox] 04:46:57 INFO - mkdir: /builds/slave/test/build/application 04:46:57 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:46:57 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:47:15 INFO - Reading from file tmpfile_stdout 04:47:15 INFO - Output received: 04:47:15 INFO - /builds/slave/test/build/application/firefox/firefox 04:47:15 INFO - Running post-action listener: _resource_record_post_action 04:47:15 INFO - ##### 04:47:15 INFO - ##### Finished install step (success) 04:47:15 INFO - ##### 04:47:15 INFO - ##### 04:47:15 INFO - ##### Running run-tests step. 04:47:15 INFO - ##### 04:47:15 INFO - Running pre-action listener: _resource_record_pre_action 04:47:15 INFO - Running main action method: run_tests 04:47:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:47:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:47:15 INFO - Python 2.7.3 04:47:15 INFO - Return code: 0 04:47:15 INFO - grabbing minidump binary from tooltool 04:47:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:47:15 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 0x153a3b0>, '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 0x153b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x153b740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:47:15 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:47:15 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:47:15 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:47:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:47:15 INFO - Return code: 0 04:47:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:47:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:47:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:47:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:47:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:47:15 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/DRsE8QyhQp-Diue66PX13g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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:47:15 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/DRsE8QyhQp-Diue66PX13g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --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:47:15 INFO - Using env: {'DISPLAY': ':0', 04:47:15 INFO - 'HOME': '/home/cltbld', 04:47:15 INFO - 'LANG': 'en_US.UTF-8', 04:47:15 INFO - 'LANGUAGE': 'en_US:en', 04:47:15 INFO - 'LOGNAME': 'cltbld', 04:47:15 INFO - 'MAIL': '/var/mail/cltbld', 04:47:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:47:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:47:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:15 INFO - 'MOZ_NO_REMOTE': '1', 04:47:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:47:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:15 INFO - 'NO_EM_RESTART': '1', 04:47:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:15 INFO - 'PWD': '/builds/slave/test', 04:47:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:47:15 INFO - 'SHELL': '/bin/bash', 04:47:15 INFO - 'SHLVL': '1', 04:47:15 INFO - 'TERM': 'linux', 04:47:15 INFO - 'TMOUT': '86400', 04:47:15 INFO - 'USER': 'cltbld', 04:47:15 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1468842384.90743-1060770222', 04:47:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:15 INFO - '_': '/tools/buildbot/bin/python'} 04:47:15 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/DRsE8QyhQp-Diue66PX13g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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:47:15 INFO - mozversion application_buildid: 20160718013034 04:47:15 INFO - mozversion application_changeset: c8ba6a6eec22033228aad26f08db5ac4ff129461 04:47:15 INFO - mozversion application_display_name: Nightly 04:47:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:47:15 INFO - mozversion application_name: Firefox 04:47:15 INFO - mozversion application_remotingname: firefox 04:47:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:47:15 INFO - mozversion application_vendor: Mozilla 04:47:15 INFO - mozversion application_version: 50.0a1 04:47:15 INFO - mozversion platform_buildid: 20160718013034 04:47:15 INFO - mozversion platform_changeset: c8ba6a6eec22033228aad26f08db5ac4ff129461 04:47:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:47:15 INFO - mozversion platform_version: 50.0a1 04:47:15 INFO - using testdate: 1468842435 04:47:15 INFO - actual date: 1468842435 04:47:15 INFO - starting webserver on 'localhost:59607' 04:47:15 INFO - SUITE-START | Running 2 tests 04:47:15 INFO - TEST-START | dromaeo_css 04:47:15 INFO - operating with platform_type : linux_ 04:47:15 INFO - Initialising browser for dromaeo_css test... 04:47:15 INFO - TEST-INFO | started process 13953 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuBOvlp/profile http://localhost:59607/getInfo.html) 04:47:18 INFO - PROCESS | 13953 | JavaScript error: , line 0: uncaught exception: undefined 04:47:19 INFO - PROCESS | 13953 | __metrics Screen width/height:1600/1200 04:47:19 INFO - PROCESS | 13953 | colorDepth:24 04:47:19 INFO - PROCESS | 13953 | Browser inner width/height: 1024/697 04:47:19 INFO - PROCESS | 13953 | __metrics 04:47:20 INFO - PROCESS | 13953 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:47:20 INFO - PROCESS | 13953 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:47:21 INFO - TEST-INFO | 13953: exit 0 04:47:21 INFO - Browser initialized. 04:47:21 INFO - Running cycle 1/1 for dromaeo_css test... 04:47:21 INFO - TEST-INFO | started process 14034 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuBOvlp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:47:33 INFO - PROCESS | 14034 | RSS: Main: 158380032 04:47:33 INFO - PROCESS | 14034 | 04:48:24 INFO - PROCESS | 14034 | 1468842504515 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:50:32 INFO - PROCESS | 14034 | Cycle 1(1): loaded http://localhost:59607/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59607/tests/dromaeo/cssquery-ext.html) 04:50:33 INFO - PROCESS | 14034 | RSS: Main: 255574016 04:50:33 INFO - PROCESS | 14034 | 04:53:35 INFO - PROCESS | 14034 | Cycle 1(1): loaded http://localhost:59607/tests/dromaeo/cssquery-ext.html (next: http://localhost:59607/tests/dromaeo/cssquery-jquery.html) 04:53:36 INFO - PROCESS | 14034 | RSS: Main: 241598464 04:53:36 INFO - PROCESS | 14034 | 04:56:38 INFO - PROCESS | 14034 | Cycle 1(1): loaded http://localhost:59607/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59607/tests/dromaeo/cssquery-mootools.html) 04:56:38 INFO - PROCESS | 14034 | RSS: Main: 239927296 04:56:38 INFO - PROCESS | 14034 | 04:59:40 INFO - PROCESS | 14034 | Cycle 1(1): loaded http://localhost:59607/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59607/tests/dromaeo/cssquery-prototype.html) 04:59:41 INFO - PROCESS | 14034 | RSS: Main: 241709056 04:59:41 INFO - PROCESS | 14034 | 05:02:44 INFO - PROCESS | 14034 | Cycle 1(1): loaded http://localhost:59607/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59607/tests/dromaeo/cssquery-yui.html) 05:02:44 INFO - PROCESS | 14034 | RSS: Main: 209358848 05:02:44 INFO - PROCESS | 14034 | 05:05:47 INFO - PROCESS | 14034 | Cycle 1(1): loaded http://localhost:59607/tests/dromaeo/cssquery-yui.html (next: http://localhost:59607/tests/dromaeo/cssquery-dojo.html) 05:05:47 INFO - PROCESS | 14034 | RSS: Main: 256851968 05:05:47 INFO - PROCESS | 14034 | 05:05:47 INFO - PROCESS | 14034 | __start_tp_report 05:05:47 INFO - PROCESS | 14034 | _x_x_mozilla_page_load 05:05:47 INFO - PROCESS | 14034 | _x_x_mozilla_page_load_details 05:05:47 INFO - PROCESS | 14034 | |i|pagename|runs| 05:05:47 INFO - PROCESS | 14034 | |0;dojo.html;3068.432340017097;3071.8156910585367;3086.459869522833;3101.7053379928925;3134.8119112853233;5115.309433226514;5202.557782588485;5286.497782710641;5374.328208973879;5403.51368376846;5276.683398996063;5286.867828304295;5298.814541491049;5350.224217488462;5384.3538775346915;4739.905201895968;4814.518548145175;4832.299316599091;4832.637552183601;4959.677620954644;4861.246506791453;4879.6828206166665;4894.388201474816;4936.456989731127;4947.158982972904;4711.175544279755;4714.858554243361;4747.76261186941;4781.497942716;4809.182438985381;4767.928481072787;4779.976100119512;4852.466228714874;4857;4905.190643543847;4816.831410900601;4825.227963525854;4830.637702172351;4846.903061938741;4893.021395720834;5165.690058596496;5225.921611175835;5279.815206467793;5309.681419114827;5321.414644389114;5642.689652069134;5671.886562268773;5672.914906276368;5708.115242137475;5725.026745453283;5575.163725441175;5706.3722990471015;5747.568932330092;5753.165790960329;5762.596618236725;5251.159814429673;5307.3896501902;5314.282571852789;5383.8384848455;5385.057614917374;5878.29460464747;5895.616784908967;5897.76408943646;5904.143899134688;5904.996150654399;5388.568914486832;5501;5530.225768392428;5545.195946587803;5557.083081291623;5617.354004289477;5721.628094173865;5724.742386592613;5729.541636669056;5733.312002559636;5594.748236329375;5629.240052592848;5636.549076073904;5648.265725455664;5648.548116150698;5502.367227768857;5512.641678290898;5535.086710692691;5646.887062258814;5666.773329066791;4286.271333873249;4291.334843099325;4293.441852559147;4323.459567554056;4325;3820.560635526894;3833.4824798652385;3838.673712734449;3864.5555761087835;3868.2263547290654;5141.820036298786;5263.578913686896;5272.446393128743;5296.523312901781;5324.5740340772645;5642.71786410686;5666.773329066791;5677.914831277534;5678.829635110953;5710.371859095496;5367.838964831061;5371.140617501259;5371.3822910365025;5373.811916582901;5416.864578385572;4825.059113472839;4827.686200397034;4837.00841327527;4875.146849301358;4902.48523904992;5810.21562089121;5816.970915145397;5820.35976042635;5820.476157145878;5821.155932389865;5651.067573850269;5662.575306852085;5664.886702266014;5666.744996475251;5668.858278543069;5618.971905140448;5695.1457281406465;5754.5684073695475;5768.105943578752;5843.532517398513;5587.776488940397;5588.050031494575;5595.244641973444;5598.188262701967;5602.327720673382;5548;5651.773929042793;5662.178984047207;5670.064439367458;5678.602497825113;5461.672299662033;5489.862753431196;5503.559715222693;5527.640703354269;5531.419200983839;5510.448955104457;5518.448155184449;5520.613557050968;5525.834224973257;5530.446955304437;5395.730213489232;5465.562754979513;5468.261784659179;5498.092814685532;5561.304836895388;5554.972225138848;5569.916451253315;5629.971850140723;5635.830925072254;5657.688827114548;5417.458254174551;5445.1832225166545;5447.754851031634;5452.563794896478;5453.672779633234 05:05:47 INFO - PROCESS | 14034 | |1;ext.html;608.5466327585949;626.2015929689646;638.3552611862018;642.2132887213162;652.500836859802;32047;43068.13863722724;43465.348019779725;43503.34744978824;43564;45151.322730159074;45565.54434455655;45588.77205613967;45598;45624.543754562445;8936.017038125818;9011.729648110535;9084.273258139334;9086.318526110535;9086.50024248666;8914.643414263453;8975.865362019542;8999.955000225022;9009.504477253748;9013.909860901373;8978.326625503081;8994.145556172152;8998.865017024717;9003.054679258681;9028.232600228988;8986.37095403322;9013.774655633597;9032.77418064547;9035.232005279526;9040.141186587263;8915.955420222923;8959.148880856308;8974.86537701935;8977.506237156953;8985.37102402832;42573.4455932645;42858;42933;43090.13819723619;43100.784496077635;3589.174489867345;3617.276544691072;3646.1249300168033;3647.6352364763575;3769.6984241260634;32961.175970600685;33173.17067073318;33277;33747.32505349904;34785.826070869734;4324.416203812508;4331.090471001062;4365.563443655641;4388;4401.713888597231;337507;339516.3024184888;340374;340443;341887;56181.71909140428;56910.430895690515;56921.715391422775;56966;57176.42823571794;35435.82282088573;36057.45913811295;36095.63904360975;37896.431553526716;37954.2409151821;15381.846181538041;15417.152056636769;15429.614259643598;15429.614259643598;15449.150296733562;11429.371384573928;11429.542818287342;11443.942780286212;11447.484863181176;11514.481848316846;19023.1439585219;19186.13662385196;19214.776470120458;19236.422907312804;19266.32567860118;6894.896576551356;7193.3166349196745;7195.784126476214;7262.673179706926;7367.631618419165;1013.2198207380276;1033.8765902928826;1081.551156270139;1132.7451323452322;1142.446273068626;33287;33536.329273414885;33581.49627755586;33706;34175.14562135967;1111.155521803419;1138.4137169357787;1151.5393842463081;1173.4836671864352;1251.2304932466468;16253.10607916576;16254.75617865733;16306.592335191715;16346.283640217605;16504.092274924995;514144;515488;516500;517662;517987;57933.4206657928;57964.42035579675;58012.41987580155;58064.4193558059;58137.127943080886;1248.8813562711528;1334.5329134802741;1363.0867318896562;1370.6984463418032;1381.7374698807193;32954.17614559559;34572;34668.47997279993;34685.306293874484;34820.13095006153;49431.752841237;49650.50349496603;49776.75111624419;49880;49900.25149622686;381338;381462;381520;381877;382161;27879.581806273327;46591.534084660074;46800.7659961698;46887;47225.527744722116;48255;48687.26969095396;49684;51485.48514514807;52467.73766131145;42812.78593607012;42968;44103.33844992264;44408.55591444044;44663.55336446724;43385.13229735451;43511.56488435075;43525;43805.780971094944;45020.54979450163;44815.55184448244;45311;45407.091858163316;45521.772391137834;45523.31715024211;36834;39855.40216896691;39958.2008359837;40493;40751;29096.7090329094;29649;29942.401151977276;30208.54687179738;30256 05:05:47 INFO - PROCESS | 14034 | |2;jquery.html;379.1942122988649;386.61724892356574;396.4212250114832;406.40258819535285;414.85687437833957;14832;18046.729299060524;19053.142608582613;19773.209071637117;19797.109130089146;17844.64310713785;18279.36022239222;18496.075196240203;18505.35231266906;18524.166412511437;4162.334026555752;5646.604737668365;5810.448007439287;5810.680412577307;5811.157382179582;6065.4844338231305;6407.3272306407625;6409.294977552466;6502.414782669559;6513.772017979371;6381.712822922957;6398;6452.903206451907;6458;6461.3538646135485;6370.904436433457;6422.903656445157;6436.388543088399;6472.741090356427;6486.059521369399;5749;5769.394213607595;5784.913226301609;5792.565557583198;5799.449052340021;22552.323430297118;22769;22781.08875644972;23634.881825590935;23660.290191294287;2321.5507639440384;2402.2793162051316;2555.501677172952;2564.6024866145776;2666.1068542038247;13868.375923083486;14840.703185936221;14851;15004.624884377869;15012.47456339023;1944.8428185229766;1954.0229885057472;2046.8464865135174;2060.8454365922466;2124.1928067334316;85171.5741421289;87642.5617871913;87710.56144719299;87714.56142719246;88560.11439885647;10160;10321.896781032094;10528.420936848393;10827.24209305341;10839.999999999842;14716.852831471762;14730;14795.556133316019;14800.259987000607;14830;7363.77908662741;7552.66013029415;7657.042869641295;7726.304632583095;7975.84048319042;7044.753433629799;7162.534435261691;7521.135069466972;7755.2632499912415;7828.491148075471;6441.935580644227;6532.444742196872;6590.47276217911;6661.700223489955;6695.665216739241;1888.6317168152352;1918.6930091185343;1965.3612575912884;2022.3730643500562;2023.5952809438172;932.4778124250441;997.805427941559;1021.9846702299471;1051.9631812886512;1060.8408738689104;19571;20089.095990680453;20163.294284699965;20241.696374554394;20504.92244914152;1017.6743442098606;1045.4250162410644;1053.204830353094;1069.561479793281;1121.6466812953893;11036.392998385167;11416.543338266543;11456.885431145749;11586.420678966186;11613.419329033515;442071;462979;485804;492574;493227;57924;80969.59515202386;85265;87057.56471217603;89184.5540772292;954.8901876284177;980.3725615606018;990.8959559246175;992.4839083676447;1028.8559601655775;16018.279177437276;16355.83644163543;17577.912110439367;17954;17956.19197136106;32776.67223327832;42559.57440425556;42677.786611066746;43304.133917322106;44380.778096109316;56287;56485.43514564966;56916.71541642265;57868;58859.70570147122;8492.74521764348;8711.869321960048;8785.604647790993;8907.10928907104;8950.641974320954;12361.505539778309;13009.154404963647;13327.933360333136;13491.932540337235;13742.93128534351;11500.309981401142;11733.647990560297;11830.053595712494;11947.342896140795;11969.401529923294;11494.94252528732;11703.707407314885;11727;11750.23623464472;12035.398230088636;11479.483423245807;11516.30902145874;11862.584809531625;12060.638180854588;12102;7268;7499.212582678741;7645.426593005435;7802.141764406025;8752.51861147643;10702.571897124339;11072.224944253825;11419.543218271176;11544.59593914209;11697.181197316106 05:05:47 INFO - PROCESS | 14034 | |3;mootools.html;1415.2569900802082;1512.2892240646895;1574.74804031355;1708.4618345221247;1731.0392732033715;8627.741167764962;9086.636534538628;9133.543322833857;9137.22333601643;9171.678991235309;7752.3410510106705;8504.447210931285;8712.73861784146;8752.606132724026;8973.371863969525;2372.6678265042865;2396.424858034077;2397.4965257295903;2397.61638137898;2399.7600239976036;2394.9640755388596;2400.291913885408;2438.6829712137487;2441.4628781668002;2443.328084776692;2058.279602139254;2114.672225804995;2369.9763002369928;2440.2801173653725;2448.52253810507;2413.6379543068506;2430.9756902430927;2441.7558244175707;2444.3155916343276;2449.5468338357373;2337.39227800773;2359.5634807560486;2360;2363.7399886012527;2368.8460250083863;9010.098990101003;9157.358984871062;9161.587728552231;9167.679131230441;9184.357095003352;5292.126799078186;5410.458954104597;5421.051316019681;5423.29497165366;5426.701531415771;3483.494893240466;3594.5506811648543;3632.763870348419;3649.3066317399607;3687.225682606656;1195.408272904909;1238.2137342787305;1253.5487224599137;1256.208588589192;1269.3906924676114;12481.31352775588;12488.375581220902;12495.062870284673;12499.312537810416;12513.93743031288;4477.597016268552;4585.72485650862;4680.836170734008;4682.157211701926;4810.735409552508;10478.580856765644;10578.576856925636;10587.947060264803;10593.152547796159;10599;5416.51251387377;5417.160340147283;5424.674519528841;5424.810131645452;5426.8371948841595;4762.452317983476;4933.333999910038;4997.825076122318;4998.100341938413;5007.69953802773;3869.438931354994;3917.2948869203815;3966.900827479336;3993.7020468347905;4028.9597104028585;1064.632701717906;1088.6951653537021;1193.3317342288174;1194.486370860521;1207.076586411396;764.300664891629;856.5717141429285;930.8184903943666;1040.6409788622914;1044.0759927464248;6077.665728384893;6092.939070609237;6099.75600975956;6232.626042437469;6356.968215158895;963.8698775665196;1019.6788011776267;1022.5807418958192;1023.5138309303021;1067.4822710985165;4375.409319741794;4476.440444944382;4508.278675411918;4514.029483661028;4563.452385713736;10843;11074.833877491845;11225.943870280596;11235.213535052468;11255.493502792395;11156.609518666808;11164.330140191614;11171.83242251367;11180.217384782987;11183.552657893755;7965.402594805413;8297.170282971654;8313.6674533018;8513.787155321043;8514.531700756517;6066.878662426639;6378.489720822416;6464.903026454513;6487.3836985486305;6496.7726129585235;9894.703158904957;10212.591496340063;10264.281500295207;10317.74205644865;10433.686989390331;10126.341787783771;10215.591376344863;10233;10257.692269231935;10293.43386113771;7904.762857114296;8225.054118776417;8230.711925082593;8230.753077407688;8238.83522329562;8420;8678.175573320525;8758.47449153053;8807.691730789391;8812.64749410042;7858.724944626911;7953.6818527260575;7995.240452157036;8059.153788852321;8216.424850260664;7573.848523029619;7656.69373225087;7724.1889601593275;7864.84270314602;7885.487443316396;7454.962725186556;7504.887426688713;7538.811529711801;7567.962160189384;7570.356519695667;5342.412334643263;5356.250124982427;5362.276092727432;5379.381371142213;5462.699551524545;5506.421825708243;5508.20131080983;5534.252875861707;5740.712964351849;5829.59192856496 05:05:47 INFO - PROCESS | 14034 | |4;prototype.html;325.2681466699925;333.38324100414235;336.1277484926616;337.8125140546997;341.29352240861397;5217.634765566412;5299.443558426367;5304.840854774353;5385.788197655525;5395.21769343445;5166.63833531652;5270.710110943896;5301.496357845998;5311.256424100619;5328.706921119337;4184.0125940178405;4198.6011328923705;4216.262154123032;4233.111046680201;4250.234957707611;3958.2677204717074;4043.2924238258333;4203.684723645723;4214.894627634319;4217;4192.37114432836;4195.4545909031785;4198.328267477189;4214.747115173084;4220.915581688364;4188.853390131346;4189.72766770159;4197.496300443966;4210;4219.2194444027955;3616.9095772605633;3648.2885837261742;3745.101175717808;3750.49368335274;3760.9623903760885;5132.538071573576;5156.974215128937;5167.080599461292;5167.224916262553;5174.09453345663;4709.693869898446;4725.598324142452;4746.264329028972;4767.1419144553965;4768.713877167381;5346.893062138774;5488.368837583689;5562.694051827189;5567.4432556744405;5583.162525621149;3998.140399814025;4017.3973903914352;4041.3533834586324;4046.3930410438375;4069.267531844267;5671.971640141773;5706.686132262724;5724.313082430135;5724.856878578069;5783.450572195635;3978.5225772906856;4158.355454904495;4169.874903752892;4171.249175148441;4183.309753890635;4159.292920203573;4164.479440069991;4170.874873753793;4186.392973018956;4200.873973780792;4767.094252092092;4769.451513076041;4782.234842425265;4792.466410748597;4798;5455.618106732491;5506;5529.50703310104;5529.695866727288;5602.411746766612;1439.6616795053365;1446.7829825526255;1447.2474313356995;1455.2869094144005;1455.323274677259;909.2634965677822;930.5626355612851;930.6696122876417;941.6704153546204;942.8161508505775;4762.14281429346;4772.904541909143;4803.303520989437;4828.975855120702;4838.879028024327;5011.373578302712;5028.974855125701;5069.797208111634;5105.442839933856;5178.663386879841;4583.793729282191;4776.853555146809;4798.47216806151;4807.543283388072;4850.1269771440775;2687.736763721087;2705.2560545850047;2711.010481174357;2726.9181924542295;2732.2896047027916;5225.354013485739;5239.659422137549;5242.895142097137;5244.344456942882;5264.394594621591;4931.090656512603;5149.588032957429;5166.405863325691;5194.870128246824;5204.323437953118;5180.274761533388;5196.830713089525;5228.2941802856885;5257.474252574789;5290.92063619046;5001.249562653043;5040.924386134137;5051.823186188466;5081.898362032813;5126.4360920297995;4800.919793046536;4958.975205123951;4985.900281994413;5026.899462010812;5038;5106.795728170831;5148.897022059613;5167.509086636764;5171.844844654666;5172.612054095883;3812.3709587918793;3994.7802870842384;4112.9588704112575;4212.041400748667;4212.684048696298;5680.358633235565;5719.513841323368;5731;5757.453041961007;5763.625364351304;5457.717436402521;5612.102063669793;5616.045272303636;5621.634593751393;5625.803096891589;5542.722863856871;5557.5831812613405;5559.972200138974;5572;5598.776048957996;5519.972400137974;5539;5564.415736347787;5573.383718721688;5576.972115139399;5441.374241962225;5555.4167312200025;5563.831595365019;5596.440355964533;5599.440055994368;5449.1826226066405;5450.31871016123;5455.781768729206;5477.1510415885605;5502.944970550243 05:05:47 INFO - PROCESS | 14034 | |5;yui.html;814.9266566009057;830.3398797955625;841.3815845353668;845.7885528617845;866.268003537011;15155.772663410044;15361.923190384061;16201.703863690906;16625.7506137408;16649;15131.621709457242;15307.693846123071;15309.617259568517;15324.157171355571;15326.693466130671;676.8307923019245;802.9598520074002;812.540914383373;834.2408408348405;834.5743670727911;821.0926925747053;839.3117643532306;840.1220724343076;840.1514470384925;840.3823189955378;880.5289170293894;882.3382463152635;886.7916039730658;887.0818702642766;888.009868996068;704.7603814703;835.3484282259847;849.6389034660244;874.9431286966359;883.0286684646901;621.3599992008238;625.2715586341906;625.4808508937571;626.3423405424286;627.8461776864698;15319.770203446957;15342.616434589114;15408.922955385264;15440.382384704712;15456.995295305882;13961.79057314141;13982.300884955814;13984.440622375092;14259.643508912257;14289.142651440843;12882.613521594367;12884.549040783528;13046.543370982065;13079.607611771662;13140.671483212996;4488.932666010012;4538.205813982573;4627.421572303462;4659.953400465985;4700.835470758541;75377.24622753757;76030.61984690097;76076.61961690211;76700;76787.61606191989;10866.511007004703;10939.83590246147;11127;11171.608993685344;11644.41777911101;20017.699734503993;20021.899890500456;20091.59816803656;20123.39629811108;20174.19303227884;8106.270435660819;8183.377669492603;8253.95873020631;8390.79023024417;8520.914790852135;4357.411749413788;4438;4595.287730401793;4669.95330046702;4820.517948205152;3477.3045390921916;3597.712183025404;3598.3882739934274;3602.963970360315;3603.5855876574005;467.32471578569323;642.9389208025231;645.4578154350369;647.1683886206202;648.2188962300511;684.0628339175362;739.548875186136;753.8643044251978;776.755322073545;785.4148659248782;10535.156347639286;10692.198085143646;10703.732406689895;11005.494286738143;11373.488193031333;670.9396154346132;697.0554898113085;787.8384931089113;794.1859593916166;808.7209912580269;4754.215554433549;5127.230915362651;5190.6366554341585;5194.7922083116255;5252.527272545412;70067.64966175136;75903;109137;111839.44080279546;111879.44060279809;61039;88792.5560372194;93773;95379;96046.51976740072;56017.43982560122;87105.12894871098;87322.56338718266;92043.53978230066;92123;9830.410175389214;9906.851397228904;9987.151092156957;9996.45019523904;10029.648962286285;37338;48320.275195871385;49964;50390.748046259534;50490.24264636107;69017;69129;75292.24707752852;76269.61865190639;77360;12237.449314780679;12275.324857132944;12476.750464990831;12649.873501265238;12795.232286062866;13892.791608126088;14205.644858878612;14224.644383890485;14277.643058923195;14690.192039437934;13615.727685446434;13651.11267767592;13703.45186192541;14391.208483533506;14415.279236038366;13301.733965320833;13386.799198011842;13451.865481345061;13481.932590337377;13527.120737152447;13308.534201302908;13469;13476.326183690971;13516.12145210558;13587.660308492366;11208.10335173168;11280.307953806667;11469.770604588028;11566.826497602711;11766.352850593299;10369.1979972329;10924;11161.107111430903;11268.38023908693;11284.548618055185 05:05:47 INFO - PROCESS | 14034 | __end_tp_report 05:05:47 INFO - PROCESS | 14034 | __start_cc_report 05:05:47 INFO - PROCESS | 14034 | _x_x_mozilla_cycle_collect,810 05:05:47 INFO - PROCESS | 14034 | __end_cc_report 05:05:47 INFO - PROCESS | 14034 | __startTimestamp1468843547741__endTimestamp 05:05:47 INFO - PROCESS | 14034 | 05:05:47 INFO - PROCESS | 14034 | ------- Summary: start ------- 05:05:47 INFO - PROCESS | 14034 | Number of tests: 6 05:05:47 INFO - PROCESS | 14034 | 05:05:47 INFO - PROCESS | 14034 | [#0] dojo.html Cycles:165 Average:5256.78 Median:5461.67 stddev:592.90 (10.9%) stddev-sans-first:569.32 05:05:47 INFO - PROCESS | 14034 | Values: 3068.4 3071.8 3086.5 3101.7 3134.8 5115.3 5202.6 5286.5 5374.3 5403.5 5276.7 5286.9 5298.8 5350.2 5384.4 4739.9 4814.5 4832.3 4832.6 4959.7 4861.2 4879.7 4894.4 4936.5 4947.2 4711.2 4714.9 4747.8 4781.5 4809.2 4767.9 4780.0 4852.5 4857.0 4905.2 4816.8 4825.2 4830.6 4846.9 4893.0 5165.7 5225.9 5279.8 5309.7 5321.4 5642.7 5671.9 5672.9 5708.1 5725.0 5575.2 5706.4 5747.6 5753.2 5762.6 5251.2 5307.4 5314.3 5383.8 5385.1 5878.3 5895.6 5897.8 5904.1 5905.0 5388.6 5501.0 5530.2 5545.2 5557.1 5617.4 5721.6 5724.7 5729.5 5733.3 5594.7 5629.2 5636.5 5648.3 5648.5 5502.4 5512.6 5535.1 5646.9 5666.8 4286.3 4291.3 4293.4 4323.5 4325.0 3820.6 3833.5 3838.7 3864.6 3868.2 5141.8 5263.6 5272.4 5296.5 5324.6 5642.7 5666.8 5677.9 5678.8 5710.4 5367.8 5371.1 5371.4 5373.8 5416.9 4825.1 4827.7 4837.0 4875.1 4902.5 5810.2 5817.0 5820.4 5820.5 5821.2 5651.1 5662.6 5664.9 5666.7 5668.9 5619.0 5695.1 5754.6 5768.1 5843.5 5587.8 5588.1 5595.2 5598.2 5602.3 5548.0 5651.8 5662.2 5670.1 5678.6 5461.7 5489.9 5503.6 5527.6 5531.4 5510.4 5518.4 5520.6 5525.8 5530.4 5395.7 5465.6 5468.3 5498.1 5561.3 5555.0 5569.9 5630.0 5635.8 5657.7 5417.5 5445.2 5447.8 5452.6 5453.7 05:05:47 INFO - PROCESS | 14034 | 05:05:47 INFO - PROCESS | 14034 | [#1] ext.html Cycles:180 Average:58132.02 Median:4327.75 stddev:110858.65 (2561.6%) stddev-sans-first:111085.50 05:05:47 INFO - PROCESS | 14034 | Values: 608.5 626.2 638.4 642.2 652.5 32047.0 43068.1 43465.3 43503.3 43564.0 45151.3 45565.5 45588.8 45598.0 45624.5 8936.0 9011.7 9084.3 9086.3 9086.5 8914.6 8975.9 9000.0 9009.5 9013.9 8978.3 8994.1 8998.9 9003.1 9028.2 8986.4 9013.8 9032.8 9035.2 9040.1 8916.0 8959.1 8974.9 8977.5 8985.4 42573.4 42858.0 42933.0 43090.1 43100.8 3589.2 3617.3 3646.1 3647.6 3769.7 32961.2 33173.2 33277.0 33747.3 34785.8 4324.4 4331.1 4365.6 4388.0 4401.7 337507.0 339516.3 340374.0 340443.0 341887.0 56181.7 56910.4 56921.7 56966.0 57176.4 35435.8 36057.5 36095.6 37896.4 37954.2 15381.8 15417.2 15429.6 15429.6 15449.2 11429.4 11429.5 11443.9 11447.5 11514.5 19023.1 19186.1 19214.8 19236.4 19266.3 6894.9 7193.3 7195.8 7262.7 7367.6 1013.2 1033.9 1081.6 1132.7 1142.4 33287.0 33536.3 33581.5 33706.0 34175.1 1111.2 1138.4 1151.5 1173.5 1251.2 16253.1 16254.8 16306.6 16346.3 16504.1 514144.0 515488.0 516500.0 517662.0 517987.0 57933.4 57964.4 58012.4 58064.4 58137.1 1248.9 1334.5 1363.1 1370.7 1381.7 32954.2 34572.0 34668.5 34685.3 34820.1 49431.8 49650.5 49776.8 49880.0 49900.3 381338.0 381462.0 381520.0 381877.0 382161.0 27879.6 46591.5 46800.8 46887.0 47225.5 48255.0 48687.3 49684.0 51485.5 52467.7 42812.8 42968.0 44103.3 44408.6 44663.6 43385.1 43511.6 43525.0 43805.8 45020.5 44815.6 45311.0 45407.1 45521.8 45523.3 36834.0 39855.4 39958.2 40493.0 40751.0 29096.7 29649.0 29942.4 30208.5 30256.0 05:05:47 INFO - PROCESS | 14034 | 05:05:47 INFO - PROCESS | 14034 | [#2] jquery.html Cycles:180 Average:28559.65 Median:2478.89 stddev:78381.74 (3162.0%) stddev-sans-first:78573.06 05:05:47 INFO - PROCESS | 14034 | Values: 379.2 386.6 396.4 406.4 414.9 14832.0 18046.7 19053.1 19773.2 19797.1 17844.6 18279.4 18496.1 18505.4 18524.2 4162.3 5646.6 5810.4 5810.7 5811.2 6065.5 6407.3 6409.3 6502.4 6513.8 6381.7 6398.0 6452.9 6458.0 6461.4 6370.9 6422.9 6436.4 6472.7 6486.1 5749.0 5769.4 5784.9 5792.6 5799.4 22552.3 22769.0 22781.1 23634.9 23660.3 2321.6 2402.3 2555.5 2564.6 2666.1 13868.4 14840.7 14851.0 15004.6 15012.5 1944.8 1954.0 2046.8 2060.8 2124.2 85171.6 87642.6 87710.6 87714.6 88560.1 10160.0 10321.9 10528.4 10827.2 10840.0 14716.9 14730.0 14795.6 14800.3 14830.0 7363.8 7552.7 7657.0 7726.3 7975.8 7044.8 7162.5 7521.1 7755.3 7828.5 6441.9 6532.4 6590.5 6661.7 6695.7 1888.6 1918.7 1965.4 2022.4 2023.6 932.5 997.8 1022.0 1052.0 1060.8 19571.0 20089.1 20163.3 20241.7 20504.9 1017.7 1045.4 1053.2 1069.6 1121.6 11036.4 11416.5 11456.9 11586.4 11613.4 442071.0 462979.0 485804.0 492574.0 493227.0 57924.0 80969.6 85265.0 87057.6 89184.6 954.9 980.4 990.9 992.5 1028.9 16018.3 16355.8 17577.9 17954.0 17956.2 32776.7 42559.6 42677.8 43304.1 44380.8 56287.0 56485.4 56916.7 57868.0 58859.7 8492.7 8711.9 8785.6 8907.1 8950.6 12361.5 13009.2 13327.9 13491.9 13742.9 11500.3 11733.6 11830.1 11947.3 11969.4 11494.9 11703.7 11727.0 11750.2 12035.4 11479.5 11516.3 11862.6 12060.6 12102.0 7268.0 7499.2 7645.4 7802.1 8752.5 10702.6 11072.2 11419.5 11544.6 11697.2 05:05:47 INFO - PROCESS | 14034 | 05:05:47 INFO - PROCESS | 14034 | [#3] mootools.html Cycles:180 Average:5967.25 Median:4574.59 stddev:3354.27 (73.3%) stddev-sans-first:3346.24 05:05:47 INFO - PROCESS | 14034 | Values: 1415.3 1512.3 1574.7 1708.5 1731.0 8627.7 9086.6 9133.5 9137.2 9171.7 7752.3 8504.4 8712.7 8752.6 8973.4 2372.7 2396.4 2397.5 2397.6 2399.8 2395.0 2400.3 2438.7 2441.5 2443.3 2058.3 2114.7 2370.0 2440.3 2448.5 2413.6 2431.0 2441.8 2444.3 2449.5 2337.4 2359.6 2360.0 2363.7 2368.8 9010.1 9157.4 9161.6 9167.7 9184.4 5292.1 5410.5 5421.1 5423.3 5426.7 3483.5 3594.6 3632.8 3649.3 3687.2 1195.4 1238.2 1253.5 1256.2 1269.4 12481.3 12488.4 12495.1 12499.3 12513.9 4477.6 4585.7 4680.8 4682.2 4810.7 10478.6 10578.6 10587.9 10593.2 10599.0 5416.5 5417.2 5424.7 5424.8 5426.8 4762.5 4933.3 4997.8 4998.1 5007.7 3869.4 3917.3 3966.9 3993.7 4029.0 1064.6 1088.7 1193.3 1194.5 1207.1 764.3 856.6 930.8 1040.6 1044.1 6077.7 6092.9 6099.8 6232.6 6357.0 963.9 1019.7 1022.6 1023.5 1067.5 4375.4 4476.4 4508.3 4514.0 4563.5 10843.0 11074.8 11225.9 11235.2 11255.5 11156.6 11164.3 11171.8 11180.2 11183.6 7965.4 8297.2 8313.7 8513.8 8514.5 6066.9 6378.5 6464.9 6487.4 6496.8 9894.7 10212.6 10264.3 10317.7 10433.7 10126.3 10215.6 10233.0 10257.7 10293.4 7904.8 8225.1 8230.7 8230.8 8238.8 8420.0 8678.2 8758.5 8807.7 8812.6 7858.7 7953.7 7995.2 8059.2 8216.4 7573.8 7656.7 7724.2 7864.8 7885.5 7455.0 7504.9 7538.8 7568.0 7570.4 5342.4 5356.3 5362.3 5379.4 5462.7 5506.4 5508.2 5534.3 5740.7 5829.6 05:05:47 INFO - PROCESS | 14034 | 05:05:47 INFO - PROCESS | 14034 | [#4] prototype.html Cycles:180 Average:4533.62 Median:5060.81 stddev:1290.93 (25.5%) stddev-sans-first:1255.32 05:05:47 INFO - PROCESS | 14034 | Values: 325.3 333.4 336.1 337.8 341.3 5217.6 5299.4 5304.8 5385.8 5395.2 5166.6 5270.7 5301.5 5311.3 5328.7 4184.0 4198.6 4216.3 4233.1 4250.2 3958.3 4043.3 4203.7 4214.9 4217.0 4192.4 4195.5 4198.3 4214.7 4220.9 4188.9 4189.7 4197.5 4210.0 4219.2 3616.9 3648.3 3745.1 3750.5 3761.0 5132.5 5157.0 5167.1 5167.2 5174.1 4709.7 4725.6 4746.3 4767.1 4768.7 5346.9 5488.4 5562.7 5567.4 5583.2 3998.1 4017.4 4041.4 4046.4 4069.3 5672.0 5706.7 5724.3 5724.9 5783.5 3978.5 4158.4 4169.9 4171.2 4183.3 4159.3 4164.5 4170.9 4186.4 4200.9 4767.1 4769.5 4782.2 4792.5 4798.0 5455.6 5506.0 5529.5 5529.7 5602.4 1439.7 1446.8 1447.2 1455.3 1455.3 909.3 930.6 930.7 941.7 942.8 4762.1 4772.9 4803.3 4829.0 4838.9 5011.4 5029.0 5069.8 5105.4 5178.7 4583.8 4776.9 4798.5 4807.5 4850.1 2687.7 2705.3 2711.0 2726.9 2732.3 5225.4 5239.7 5242.9 5244.3 5264.4 4931.1 5149.6 5166.4 5194.9 5204.3 5180.3 5196.8 5228.3 5257.5 5290.9 5001.2 5040.9 5051.8 5081.9 5126.4 4800.9 4959.0 4985.9 5026.9 5038.0 5106.8 5148.9 5167.5 5171.8 5172.6 3812.4 3994.8 4113.0 4212.0 4212.7 5680.4 5719.5 5731.0 5757.5 5763.6 5457.7 5612.1 5616.0 5621.6 5625.8 5542.7 5557.6 5560.0 5572.0 5598.8 5520.0 5539.0 5564.4 5573.4 5577.0 5441.4 5555.4 5563.8 5596.4 5599.4 5449.2 5450.3 5455.8 5477.2 5502.9 05:05:47 INFO - PROCESS | 14034 | 05:05:47 INFO - PROCESS | 14034 | [#5] yui.html Cycles:180 Average:19765.40 Median:4643.69 stddev:27410.91 (590.3%) stddev-sans-first:27450.88 05:05:47 INFO - PROCESS | 14034 | Values: 814.9 830.3 841.4 845.8 866.3 15155.8 15361.9 16201.7 16625.8 16649.0 15131.6 15307.7 15309.6 15324.2 15326.7 676.8 803.0 812.5 834.2 834.6 821.1 839.3 840.1 840.2 840.4 880.5 882.3 886.8 887.1 888.0 704.8 835.3 849.6 874.9 883.0 621.4 625.3 625.5 626.3 627.8 15319.8 15342.6 15408.9 15440.4 15457.0 13961.8 13982.3 13984.4 14259.6 14289.1 12882.6 12884.5 13046.5 13079.6 13140.7 4488.9 4538.2 4627.4 4660.0 4700.8 75377.2 76030.6 76076.6 76700.0 76787.6 10866.5 10939.8 11127.0 11171.6 11644.4 20017.7 20021.9 20091.6 20123.4 20174.2 8106.3 8183.4 8254.0 8390.8 8520.9 4357.4 4438.0 4595.3 4670.0 4820.5 3477.3 3597.7 3598.4 3603.0 3603.6 467.3 642.9 645.5 647.2 648.2 684.1 739.5 753.9 776.8 785.4 10535.2 10692.2 10703.7 11005.5 11373.5 670.9 697.1 787.8 794.2 808.7 4754.2 5127.2 5190.6 5194.8 5252.5 70067.6 75903.0 109137.0 111839.4 111879.4 61039.0 88792.6 93773.0 95379.0 96046.5 56017.4 87105.1 87322.6 92043.5 92123.0 9830.4 9906.9 9987.2 9996.5 10029.6 37338.0 48320.3 49964.0 50390.7 50490.2 69017.0 69129.0 75292.2 76269.6 77360.0 12237.4 12275.3 12476.8 12649.9 12795.2 13892.8 14205.6 14224.6 14277.6 14690.2 13615.7 13651.1 13703.5 14391.2 14415.3 13301.7 13386.8 13451.9 13481.9 13527.1 13308.5 13469.0 13476.3 13516.1 13587.7 11208.1 11280.3 11469.8 11566.8 11766.4 10369.2 10924.0 11161.1 11268.4 11284.5 05:05:47 INFO - PROCESS | 14034 | -------- Summary: end -------- 05:05:47 INFO - PROCESS | 14034 | 05:05:48 INFO - TEST-INFO | 14034: exit 0 05:05:48 INFO - TEST-OK | dromaeo_css | took 1112968ms 05:05:48 INFO - TEST-START | kraken 05:05:48 INFO - operating with platform_type : linux_ 05:05:48 INFO - Initialising browser for kraken test... 05:05:48 INFO - TEST-INFO | started process 14226 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ5ZjzP/profile http://localhost:59607/getInfo.html) 05:05:51 INFO - PROCESS | 14226 | JavaScript error: , line 0: uncaught exception: undefined 05:05:52 INFO - PROCESS | 14226 | __metrics Screen width/height:1600/1200 05:05:52 INFO - PROCESS | 14226 | colorDepth:24 05:05:52 INFO - PROCESS | 14226 | Browser inner width/height: 1024/697 05:05:52 INFO - PROCESS | 14226 | __metrics 05:05:53 INFO - PROCESS | 14226 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:05:53 INFO - PROCESS | 14226 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:05:54 INFO - TEST-INFO | 14226: exit 0 05:05:54 INFO - Browser initialized. 05:05:54 INFO - Running cycle 1/1 for kraken test... 05:05:54 INFO - TEST-INFO | started process 14309 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ5ZjzP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:06:05 INFO - PROCESS | 14309 | RSS: Main: 158011392 05:06:05 INFO - PROCESS | 14309 | 05:06:08 INFO - PROCESS | 14309 | Cycle 1(1): loaded http://localhost:59607/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59607/tests/kraken/driver.html?testName=audio-beat-detection) 05:06:09 INFO - PROCESS | 14309 | RSS: Main: 217178112 05:06:09 INFO - PROCESS | 14309 | 05:06:11 INFO - PROCESS | 14309 | Cycle 1(1): loaded http://localhost:59607/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59607/tests/kraken/driver.html?testName=audio-dft) 05:06:12 INFO - PROCESS | 14309 | RSS: Main: 205103104 05:06:12 INFO - PROCESS | 14309 | 05:06:15 INFO - PROCESS | 14309 | Cycle 1(1): loaded http://localhost:59607/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59607/tests/kraken/driver.html?testName=audio-fft) 05:06:16 INFO - PROCESS | 14309 | RSS: Main: 271110144 05:06:16 INFO - PROCESS | 14309 | 05:06:18 INFO - PROCESS | 14309 | Cycle 1(1): loaded http://localhost:59607/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59607/tests/kraken/driver.html?testName=audio-oscillator) 05:06:18 INFO - PROCESS | 14309 | RSS: Main: 181391360 05:06:18 INFO - PROCESS | 14309 | 05:06:21 INFO - PROCESS | 14309 | Cycle 1(1): loaded http://localhost:59607/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59607/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:06:21 INFO - PROCESS | 14309 | RSS: Main: 186236928 05:06:21 INFO - PROCESS | 14309 | 05:06:24 INFO - PROCESS | 14309 | Cycle 1(1): loaded http://localhost:59607/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59607/tests/kraken/driver.html?testName=imaging-darkroom) 05:06:25 INFO - PROCESS | 14309 | RSS: Main: 220200960 05:06:25 INFO - PROCESS | 14309 | 05:06:28 INFO - PROCESS | 14309 | Cycle 1(1): loaded http://localhost:59607/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59607/tests/kraken/driver.html?testName=imaging-desaturate) 05:06:29 INFO - PROCESS | 14309 | RSS: Main: 222224384 05:06:29 INFO - PROCESS | 14309 | 05:06:32 INFO - PROCESS | 14309 | Cycle 1(1): loaded http://localhost:59607/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59607/tests/kraken/driver.html?testName=json-parse-financial) 05:06:32 INFO - PROCESS | 14309 | RSS: Main: 222863360 05:06:32 INFO - PROCESS | 14309 | 05:06:34 INFO - PROCESS | 14309 | Cycle 1(1): loaded http://localhost:59607/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59607/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:06:34 INFO - PROCESS | 14309 | RSS: Main: 210612224 05:06:34 INFO - PROCESS | 14309 | 05:06:36 INFO - PROCESS | 14309 | Cycle 1(1): loaded http://localhost:59607/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59607/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:06:37 INFO - PROCESS | 14309 | RSS: Main: 213217280 05:06:37 INFO - PROCESS | 14309 | 05:06:39 INFO - PROCESS | 14309 | Cycle 1(1): loaded http://localhost:59607/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59607/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:06:39 INFO - PROCESS | 14309 | RSS: Main: 211083264 05:06:39 INFO - PROCESS | 14309 | 05:06:42 INFO - PROCESS | 14309 | Cycle 1(1): loaded http://localhost:59607/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59607/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:06:42 INFO - PROCESS | 14309 | RSS: Main: 224198656 05:06:42 INFO - PROCESS | 14309 | 05:06:45 INFO - PROCESS | 14309 | Cycle 1(1): loaded http://localhost:59607/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59607/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:06:46 INFO - PROCESS | 14309 | RSS: Main: 225193984 05:06:46 INFO - PROCESS | 14309 | 05:06:47 INFO - PROCESS | 14309 | Cycle 1(1): loaded http://localhost:59607/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59607/tests/kraken/driver.html?testName=ai-astar) 05:06:47 INFO - PROCESS | 14309 | RSS: Main: 267632640 05:06:47 INFO - PROCESS | 14309 | 05:06:47 INFO - PROCESS | 14309 | __start_tp_report 05:06:47 INFO - PROCESS | 14309 | _x_x_mozilla_page_load 05:06:47 INFO - PROCESS | 14309 | _x_x_mozilla_page_load_details 05:06:47 INFO - PROCESS | 14309 | |i|pagename|runs| 05:06:47 INFO - PROCESS | 14309 | |0;ai-astar;105;114;112;110;112;112;111;113;111;111 05:06:47 INFO - PROCESS | 14309 | |1;audio-beat-detection;147;122;123;170;119;120;143;118;145;117 05:06:47 INFO - PROCESS | 14309 | |2;audio-dft;161;161;161;161;160;159;164;160;160;160 05:06:47 INFO - PROCESS | 14309 | |3;audio-fft;74;76;74;109;74;74;79;74;100;74 05:06:47 INFO - PROCESS | 14309 | |4;audio-oscillator;84;84;128;83;84;83;124;83;84;133 05:06:47 INFO - PROCESS | 14309 | |5;imaging-gaussian-blur;117;117;117;117;116;117;117;116;117;116 05:06:47 INFO - PROCESS | 14309 | |6;imaging-darkroom;146;145;146;146;145;147;145;146;146;146 05:06:47 INFO - PROCESS | 14309 | |7;imaging-desaturate;95;94;94;95;95;94;95;95;95;95 05:06:47 INFO - PROCESS | 14309 | |8;json-parse-financial;50;49;50;50;49;50;50;49;51;50 05:06:47 INFO - PROCESS | 14309 | |9;json-stringify-tinderbox;63;63;63;63;63;64;64;64;63;64 05:06:47 INFO - PROCESS | 14309 | |10;stanford-crypto-aes;83;75;81;76;78;81;75;75;74;74 05:06:47 INFO - PROCESS | 14309 | |11;stanford-crypto-ccm;117;129;119;119;116;120;119;119;160;119 05:06:47 INFO - PROCESS | 14309 | |12;stanford-crypto-pbkdf2;156;159;154;156;158;158;157;167;159;153 05:06:47 INFO - PROCESS | 14309 | |13;stanford-crypto-sha256-iterative;64;63;66;62;66;70;62;61;61;64 05:06:47 INFO - PROCESS | 14309 | __end_tp_report 05:06:47 INFO - PROCESS | 14309 | __start_cc_report 05:06:47 INFO - PROCESS | 14309 | _x_x_mozilla_cycle_collect,1689 05:06:47 INFO - PROCESS | 14309 | __end_cc_report 05:06:47 INFO - PROCESS | 14309 | __startTimestamp1468843607993__endTimestamp 05:06:47 INFO - PROCESS | 14309 | 05:06:48 INFO - PROCESS | 14309 | ------- Summary: start ------- 05:06:48 INFO - PROCESS | 14309 | Number of tests: 14 05:06:48 INFO - PROCESS | 14309 | 05:06:48 INFO - PROCESS | 14309 | [#0] ai-astar Cycles:10 Average:111.10 Median:112.00 stddev:2.42 (2.2%) stddev-sans-first:1.20 05:06:48 INFO - PROCESS | 14309 | Values: 105.0 114.0 112.0 110.0 112.0 112.0 111.0 113.0 111.0 111.0 05:06:48 INFO - PROCESS | 14309 | 05:06:48 INFO - PROCESS | 14309 | [#1] audio-beat-detection Cycles:10 Average:132.40 Median:133.00 stddev:17.86 (13.4%) stddev-sans-first:18.15 05:06:48 INFO - PROCESS | 14309 | Values: 147.0 122.0 123.0 170.0 119.0 120.0 143.0 118.0 145.0 117.0 05:06:48 INFO - PROCESS | 14309 | 05:06:48 INFO - PROCESS | 14309 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:1.34 (0.8%) stddev-sans-first:1.41 05:06:48 INFO - PROCESS | 14309 | Values: 161.0 161.0 161.0 161.0 160.0 159.0 164.0 160.0 160.0 160.0 05:06:48 INFO - PROCESS | 14309 | 05:06:48 INFO - PROCESS | 14309 | [#3] audio-fft Cycles:10 Average:80.80 Median:74.00 stddev:12.77 (17.3%) stddev-sans-first:13.31 05:06:48 INFO - PROCESS | 14309 | Values: 74.0 76.0 74.0 109.0 74.0 74.0 79.0 74.0 100.0 74.0 05:06:48 INFO - PROCESS | 14309 | 05:06:48 INFO - PROCESS | 14309 | [#4] audio-oscillator Cycles:10 Average:97.00 Median:83.50 stddev:21.73 (26.0%) stddev-sans-first:22.53 05:06:48 INFO - PROCESS | 14309 | Values: 84.0 84.0 128.0 83.0 84.0 83.0 124.0 83.0 84.0 133.0 05:06:48 INFO - PROCESS | 14309 | 05:06:48 INFO - PROCESS | 14309 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 05:06:48 INFO - PROCESS | 14309 | Values: 117.0 117.0 117.0 117.0 116.0 117.0 117.0 116.0 117.0 116.0 05:06:48 INFO - PROCESS | 14309 | 05:06:48 INFO - PROCESS | 14309 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 05:06:48 INFO - PROCESS | 14309 | Values: 146.0 145.0 146.0 146.0 145.0 147.0 145.0 146.0 146.0 146.0 05:06:48 INFO - PROCESS | 14309 | 05:06:48 INFO - PROCESS | 14309 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 05:06:48 INFO - PROCESS | 14309 | Values: 95.0 94.0 94.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 05:06:48 INFO - PROCESS | 14309 | 05:06:48 INFO - PROCESS | 14309 | [#8] json-parse-financial Cycles:10 Average:49.80 Median:50.00 stddev:0.63 (1.3%) stddev-sans-first:0.67 05:06:48 INFO - PROCESS | 14309 | Values: 50.0 49.0 50.0 50.0 49.0 50.0 50.0 49.0 51.0 50.0 05:06:48 INFO - PROCESS | 14309 | 05:06:48 INFO - PROCESS | 14309 | [#9] json-stringify-tinderbox Cycles:10 Average:63.40 Median:63.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 05:06:48 INFO - PROCESS | 14309 | Values: 63.0 63.0 63.0 63.0 63.0 64.0 64.0 64.0 63.0 64.0 05:06:48 INFO - PROCESS | 14309 | 05:06:48 INFO - PROCESS | 14309 | [#10] stanford-crypto-aes Cycles:10 Average:77.20 Median:77.00 stddev:3.33 (4.3%) stddev-sans-first:2.79 05:06:48 INFO - PROCESS | 14309 | Values: 83.0 75.0 81.0 76.0 78.0 81.0 75.0 75.0 74.0 74.0 05:06:48 INFO - PROCESS | 14309 | 05:06:48 INFO - PROCESS | 14309 | [#11] stanford-crypto-ccm Cycles:10 Average:123.70 Median:119.00 stddev:13.22 (11.1%) stddev-sans-first:13.80 05:06:48 INFO - PROCESS | 14309 | Values: 117.0 129.0 119.0 119.0 116.0 120.0 119.0 119.0 160.0 119.0 05:06:48 INFO - PROCESS | 14309 | 05:06:48 INFO - PROCESS | 14309 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.70 Median:158.00 stddev:3.83 (2.4%) stddev-sans-first:4.01 05:06:48 INFO - PROCESS | 14309 | Values: 156.0 159.0 154.0 156.0 158.0 158.0 157.0 167.0 159.0 153.0 05:06:48 INFO - PROCESS | 14309 | 05:06:48 INFO - PROCESS | 14309 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.90 Median:64.00 stddev:2.81 (4.4%) stddev-sans-first:2.98 05:06:48 INFO - PROCESS | 14309 | Values: 64.0 63.0 66.0 62.0 66.0 70.0 62.0 61.0 61.0 64.0 05:06:48 INFO - PROCESS | 14309 | -------- Summary: end -------- 05:06:48 INFO - PROCESS | 14309 | 05:06:48 INFO - TEST-INFO | 14309: exit 0 05:06:48 INFO - TEST-OK | kraken | took 60503ms 05:06:48 INFO - SUITE-END | took 1173s 05:06:49 INFO - Completed test suite (00:19:33) 05:06:49 INFO - javascript benchmark 05:06:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3068.432340017097, 3071.8156910585367, 3086.459869522833, 3101.7053379928925, 3134.8119112853233, 5115.309433226514, 5202.557782588485, 5286.497782710641, 5374.328208973879, 5403.51368376846, 5276.683398996063, 5286.867828304295, 5298.814541491049, 5350.224217488462, 5384.3538775346915, 4739.905201895968, 4814.518548145175, 4832.299316599091, 4832.637552183601, 4959.677620954644, 4861.246506791453, 4879.6828206166665, 4894.388201474816, 4936.456989731127, 4947.158982972904, 4711.175544279755, 4714.858554243361, 4747.76261186941, 4781.497942716, 4809.182438985381, 4767.928481072787, 4779.976100119512, 4852.466228714874, 4857.0, 4905.190643543847, 4816.831410900601, 4825.227963525854, 4830.637702172351, 4846.903061938741, 4893.021395720834, 5165.690058596496, 5225.921611175835, 5279.815206467793, 5309.681419114827, 5321.414644389114, 5642.689652069134, 5671.886562268773, 5672.914906276368, 5708.115242137475, 5725.026745453283, 5575.163725441175, 5706.3722990471015, 5747.568932330092, 5753.165790960329, 5762.596618236725, 5251.159814429673, 5307.3896501902, 5314.282571852789, 5383.8384848455, 5385.057614917374, 5878.29460464747, 5895.616784908967, 5897.76408943646, 5904.143899134688, 5904.996150654399, 5388.568914486832, 5501.0, 5530.225768392428, 5545.195946587803, 5557.083081291623, 5617.354004289477, 5721.628094173865, 5724.742386592613, 5729.541636669056, 5733.312002559636, 5594.748236329375, 5629.240052592848, 5636.549076073904, 5648.265725455664, 5648.548116150698, 5502.367227768857, 5512.641678290898, 5535.086710692691, 5646.887062258814, 5666.773329066791, 4286.271333873249, 4291.334843099325, 4293.441852559147, 4323.459567554056, 4325.0, 3820.560635526894, 3833.4824798652385, 3838.673712734449, 3864.5555761087835, 3868.2263547290654, 5141.820036298786, 5263.578913686896, 5272.446393128743, 5296.523312901781, 5324.5740340772645, 5642.71786410686, 5666.773329066791, 5677.914831277534, 5678.829635110953, 5710.371859095496, 5367.838964831061, 5371.140617501259, 5371.3822910365025, 5373.811916582901, 5416.864578385572, 4825.059113472839, 4827.686200397034, 4837.00841327527, 4875.146849301358, 4902.48523904992, 5810.21562089121, 5816.970915145397, 5820.35976042635, 5820.476157145878, 5821.155932389865, 5651.067573850269, 5662.575306852085, 5664.886702266014, 5666.744996475251, 5668.858278543069, 5618.971905140448, 5695.1457281406465, 5754.5684073695475, 5768.105943578752, 5843.532517398513, 5587.776488940397, 5588.050031494575, 5595.244641973444, 5598.188262701967, 5602.327720673382, 5548.0, 5651.773929042793, 5662.178984047207, 5670.064439367458, 5678.602497825113, 5461.672299662033, 5489.862753431196, 5503.559715222693, 5527.640703354269, 5531.419200983839, 5510.448955104457, 5518.448155184449, 5520.613557050968, 5525.834224973257, 5530.446955304437, 5395.730213489232, 5465.562754979513, 5468.261784659179, 5498.092814685532, 5561.304836895388, 5554.972225138848, 5569.916451253315, 5629.971850140723, 5635.830925072254, 5657.688827114548, 5417.458254174551, 5445.1832225166545, 5447.754851031634, 5452.563794896478, 5453.672779633234], "value": 5217.06230894731, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [608.5466327585949, 626.2015929689646, 638.3552611862018, 642.2132887213162, 652.500836859802, 32047.0, 43068.13863722724, 43465.348019779725, 43503.34744978824, 43564.0, 45151.322730159074, 45565.54434455655, 45588.77205613967, 45598.0, 45624.543754562445, 8936.017038125818, 9011.729648110535, 9084.273258139334, 9086.318526110535, 9086.50024248666, 8914.643414263453, 8975.865362019542, 8999.955000225022, 9009.504477253748, 9013.909860901373, 8978.326625503081, 8994.145556172152, 8998.865017024717, 9003.054679258681, 9028.232600228988, 8986.37095403322, 9013.774655633597, 9032.77418064547, 9035.232005279526, 9040.141186587263, 8915.955420222923, 8959.148880856308, 8974.86537701935, 8977.506237156953, 8985.37102402832, 42573.4455932645, 42858.0, 42933.0, 43090.13819723619, 43100.784496077635, 3589.174489867345, 3617.276544691072, 3646.1249300168033, 3647.6352364763575, 3769.6984241260634, 32961.175970600685, 33173.17067073318, 33277.0, 33747.32505349904, 34785.826070869734, 4324.416203812508, 4331.090471001062, 4365.563443655641, 4388.0, 4401.713888597231, 337507.0, 339516.3024184888, 340374.0, 340443.0, 341887.0, 56181.71909140428, 56910.430895690515, 56921.715391422775, 56966.0, 57176.42823571794, 35435.82282088573, 36057.45913811295, 36095.63904360975, 37896.431553526716, 37954.2409151821, 15381.846181538041, 15417.152056636769, 15429.614259643598, 15429.614259643598, 15449.150296733562, 11429.371384573928, 11429.542818287342, 11443.942780286212, 11447.484863181176, 11514.481848316846, 19023.1439585219, 19186.13662385196, 19214.776470120458, 19236.422907312804, 19266.32567860118, 6894.896576551356, 7193.3166349196745, 7195.784126476214, 7262.673179706926, 7367.631618419165, 1013.2198207380276, 1033.8765902928826, 1081.551156270139, 1132.7451323452322, 1142.446273068626, 33287.0, 33536.329273414885, 33581.49627755586, 33706.0, 34175.14562135967, 1111.155521803419, 1138.4137169357787, 1151.5393842463081, 1173.4836671864352, 1251.2304932466468, 16253.10607916576, 16254.75617865733, 16306.592335191715, 16346.283640217605, 16504.092274924995, 514144.0, 515488.0, 516500.0, 517662.0, 517987.0, 57933.4206657928, 57964.42035579675, 58012.41987580155, 58064.4193558059, 58137.127943080886, 1248.8813562711528, 1334.5329134802741, 1363.0867318896562, 1370.6984463418032, 1381.7374698807193, 32954.17614559559, 34572.0, 34668.47997279993, 34685.306293874484, 34820.13095006153, 49431.752841237, 49650.50349496603, 49776.75111624419, 49880.0, 49900.25149622686, 381338.0, 381462.0, 381520.0, 381877.0, 382161.0, 27879.581806273327, 46591.534084660074, 46800.7659961698, 46887.0, 47225.527744722116, 48255.0, 48687.26969095396, 49684.0, 51485.48514514807, 52467.73766131145, 42812.78593607012, 42968.0, 44103.33844992264, 44408.55591444044, 44663.55336446724, 43385.13229735451, 43511.56488435075, 43525.0, 43805.780971094944, 45020.54979450163, 44815.55184448244, 45311.0, 45407.091858163316, 45521.772391137834, 45523.31715024211, 36834.0, 39855.40216896691, 39958.2008359837, 40493.0, 40751.0, 29096.7090329094, 29649.0, 29942.401151977276, 30208.54687179738, 30256.0], "value": 20273.439651114448, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.1942122988649, 386.61724892356574, 396.4212250114832, 406.40258819535285, 414.85687437833957, 14832.0, 18046.729299060524, 19053.142608582613, 19773.209071637117, 19797.109130089146, 17844.64310713785, 18279.36022239222, 18496.075196240203, 18505.35231266906, 18524.166412511437, 4162.334026555752, 5646.604737668365, 5810.448007439287, 5810.680412577307, 5811.157382179582, 6065.4844338231305, 6407.3272306407625, 6409.294977552466, 6502.414782669559, 6513.772017979371, 6381.712822922957, 6398.0, 6452.903206451907, 6458.0, 6461.3538646135485, 6370.904436433457, 6422.903656445157, 6436.388543088399, 6472.741090356427, 6486.059521369399, 5749.0, 5769.394213607595, 5784.913226301609, 5792.565557583198, 5799.449052340021, 22552.323430297118, 22769.0, 22781.08875644972, 23634.881825590935, 23660.290191294287, 2321.5507639440384, 2402.2793162051316, 2555.501677172952, 2564.6024866145776, 2666.1068542038247, 13868.375923083486, 14840.703185936221, 14851.0, 15004.624884377869, 15012.47456339023, 1944.8428185229766, 1954.0229885057472, 2046.8464865135174, 2060.8454365922466, 2124.1928067334316, 85171.5741421289, 87642.5617871913, 87710.56144719299, 87714.56142719246, 88560.11439885647, 10160.0, 10321.896781032094, 10528.420936848393, 10827.24209305341, 10839.999999999842, 14716.852831471762, 14730.0, 14795.556133316019, 14800.259987000607, 14830.0, 7363.77908662741, 7552.66013029415, 7657.042869641295, 7726.304632583095, 7975.84048319042, 7044.753433629799, 7162.534435261691, 7521.135069466972, 7755.2632499912415, 7828.491148075471, 6441.935580644227, 6532.444742196872, 6590.47276217911, 6661.700223489955, 6695.665216739241, 1888.6317168152352, 1918.6930091185343, 1965.3612575912884, 2022.3730643500562, 2023.5952809438172, 932.4778124250441, 997.805427941559, 1021.9846702299471, 1051.9631812886512, 1060.8408738689104, 19571.0, 20089.095990680453, 20163.294284699965, 20241.696374554394, 20504.92244914152, 1017.6743442098606, 1045.4250162410644, 1053.204830353094, 1069.561479793281, 1121.6466812953893, 11036.392998385167, 11416.543338266543, 11456.885431145749, 11586.420678966186, 11613.419329033515, 442071.0, 462979.0, 485804.0, 492574.0, 493227.0, 57924.0, 80969.59515202386, 85265.0, 87057.56471217603, 89184.5540772292, 954.8901876284177, 980.3725615606018, 990.8959559246175, 992.4839083676447, 1028.8559601655775, 16018.279177437276, 16355.83644163543, 17577.912110439367, 17954.0, 17956.19197136106, 32776.67223327832, 42559.57440425556, 42677.786611066746, 43304.133917322106, 44380.778096109316, 56287.0, 56485.43514564966, 56916.71541642265, 57868.0, 58859.70570147122, 8492.74521764348, 8711.869321960048, 8785.604647790993, 8907.10928907104, 8950.641974320954, 12361.505539778309, 13009.154404963647, 13327.933360333136, 13491.932540337235, 13742.93128534351, 11500.309981401142, 11733.647990560297, 11830.053595712494, 11947.342896140795, 11969.401529923294, 11494.94252528732, 11703.707407314885, 11727.0, 11750.23623464472, 12035.398230088636, 11479.483423245807, 11516.30902145874, 11862.584809531625, 12060.638180854588, 12102.0, 7268.0, 7499.212582678741, 7645.426593005435, 7802.141764406025, 8752.51861147643, 10702.571897124339, 11072.224944253825, 11419.543218271176, 11544.59593914209, 11697.181197316106], "value": 9429.183601617468, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1415.2569900802082, 1512.2892240646895, 1574.74804031355, 1708.4618345221247, 1731.0392732033715, 8627.741167764962, 9086.636534538628, 9133.543322833857, 9137.22333601643, 9171.678991235309, 7752.3410510106705, 8504.447210931285, 8712.73861784146, 8752.606132724026, 8973.371863969525, 2372.6678265042865, 2396.424858034077, 2397.4965257295903, 2397.61638137898, 2399.7600239976036, 2394.9640755388596, 2400.291913885408, 2438.6829712137487, 2441.4628781668002, 2443.328084776692, 2058.279602139254, 2114.672225804995, 2369.9763002369928, 2440.2801173653725, 2448.52253810507, 2413.6379543068506, 2430.9756902430927, 2441.7558244175707, 2444.3155916343276, 2449.5468338357373, 2337.39227800773, 2359.5634807560486, 2360.0, 2363.7399886012527, 2368.8460250083863, 9010.098990101003, 9157.358984871062, 9161.587728552231, 9167.679131230441, 9184.357095003352, 5292.126799078186, 5410.458954104597, 5421.051316019681, 5423.29497165366, 5426.701531415771, 3483.494893240466, 3594.5506811648543, 3632.763870348419, 3649.3066317399607, 3687.225682606656, 1195.408272904909, 1238.2137342787305, 1253.5487224599137, 1256.208588589192, 1269.3906924676114, 12481.31352775588, 12488.375581220902, 12495.062870284673, 12499.312537810416, 12513.93743031288, 4477.597016268552, 4585.72485650862, 4680.836170734008, 4682.157211701926, 4810.735409552508, 10478.580856765644, 10578.576856925636, 10587.947060264803, 10593.152547796159, 10599.0, 5416.51251387377, 5417.160340147283, 5424.674519528841, 5424.810131645452, 5426.8371948841595, 4762.452317983476, 4933.333999910038, 4997.825076122318, 4998.100341938413, 5007.69953802773, 3869.438931354994, 3917.2948869203815, 3966.900827479336, 3993.7020468347905, 4028.9597104028585, 1064.632701717906, 1088.6951653537021, 1193.3317342288174, 1194.486370860521, 1207.076586411396, 764.300664891629, 856.5717141429285, 930.8184903943666, 1040.6409788622914, 1044.0759927464248, 6077.665728384893, 6092.939070609237, 6099.75600975956, 6232.626042437469, 6356.968215158895, 963.8698775665196, 1019.6788011776267, 1022.5807418958192, 1023.5138309303021, 1067.4822710985165, 4375.409319741794, 4476.440444944382, 4508.278675411918, 4514.029483661028, 4563.452385713736, 10843.0, 11074.833877491845, 11225.943870280596, 11235.213535052468, 11255.493502792395, 11156.609518666808, 11164.330140191614, 11171.83242251367, 11180.217384782987, 11183.552657893755, 7965.402594805413, 8297.170282971654, 8313.6674533018, 8513.787155321043, 8514.531700756517, 6066.878662426639, 6378.489720822416, 6464.903026454513, 6487.3836985486305, 6496.7726129585235, 9894.703158904957, 10212.591496340063, 10264.281500295207, 10317.74205644865, 10433.686989390331, 10126.341787783771, 10215.591376344863, 10233.0, 10257.692269231935, 10293.43386113771, 7904.762857114296, 8225.054118776417, 8230.711925082593, 8230.753077407688, 8238.83522329562, 8420.0, 8678.175573320525, 8758.47449153053, 8807.691730789391, 8812.64749410042, 7858.724944626911, 7953.6818527260575, 7995.240452157036, 8059.153788852321, 8216.424850260664, 7573.848523029619, 7656.69373225087, 7724.1889601593275, 7864.84270314602, 7885.487443316396, 7454.962725186556, 7504.887426688713, 7538.811529711801, 7567.962160189384, 7570.356519695667, 5342.412334643263, 5356.250124982427, 5362.276092727432, 5379.381371142213, 5462.699551524545, 5506.421825708243, 5508.20131080983, 5534.252875861707, 5740.712964351849, 5829.59192856496], "value": 4776.339333808913, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.2681466699925, 333.38324100414235, 336.1277484926616, 337.8125140546997, 341.29352240861397, 5217.634765566412, 5299.443558426367, 5304.840854774353, 5385.788197655525, 5395.21769343445, 5166.63833531652, 5270.710110943896, 5301.496357845998, 5311.256424100619, 5328.706921119337, 4184.0125940178405, 4198.6011328923705, 4216.262154123032, 4233.111046680201, 4250.234957707611, 3958.2677204717074, 4043.2924238258333, 4203.684723645723, 4214.894627634319, 4217.0, 4192.37114432836, 4195.4545909031785, 4198.328267477189, 4214.747115173084, 4220.915581688364, 4188.853390131346, 4189.72766770159, 4197.496300443966, 4210.0, 4219.2194444027955, 3616.9095772605633, 3648.2885837261742, 3745.101175717808, 3750.49368335274, 3760.9623903760885, 5132.538071573576, 5156.974215128937, 5167.080599461292, 5167.224916262553, 5174.09453345663, 4709.693869898446, 4725.598324142452, 4746.264329028972, 4767.1419144553965, 4768.713877167381, 5346.893062138774, 5488.368837583689, 5562.694051827189, 5567.4432556744405, 5583.162525621149, 3998.140399814025, 4017.3973903914352, 4041.3533834586324, 4046.3930410438375, 4069.267531844267, 5671.971640141773, 5706.686132262724, 5724.313082430135, 5724.856878578069, 5783.450572195635, 3978.5225772906856, 4158.355454904495, 4169.874903752892, 4171.249175148441, 4183.309753890635, 4159.292920203573, 4164.479440069991, 4170.874873753793, 4186.392973018956, 4200.873973780792, 4767.094252092092, 4769.451513076041, 4782.234842425265, 4792.466410748597, 4798.0, 5455.618106732491, 5506.0, 5529.50703310104, 5529.695866727288, 5602.411746766612, 1439.6616795053365, 1446.7829825526255, 1447.2474313356995, 1455.2869094144005, 1455.323274677259, 909.2634965677822, 930.5626355612851, 930.6696122876417, 941.6704153546204, 942.8161508505775, 4762.14281429346, 4772.904541909143, 4803.303520989437, 4828.975855120702, 4838.879028024327, 5011.373578302712, 5028.974855125701, 5069.797208111634, 5105.442839933856, 5178.663386879841, 4583.793729282191, 4776.853555146809, 4798.47216806151, 4807.543283388072, 4850.1269771440775, 2687.736763721087, 2705.2560545850047, 2711.010481174357, 2726.9181924542295, 2732.2896047027916, 5225.354013485739, 5239.659422137549, 5242.895142097137, 5244.344456942882, 5264.394594621591, 4931.090656512603, 5149.588032957429, 5166.405863325691, 5194.870128246824, 5204.323437953118, 5180.274761533388, 5196.830713089525, 5228.2941802856885, 5257.474252574789, 5290.92063619046, 5001.249562653043, 5040.924386134137, 5051.823186188466, 5081.898362032813, 5126.4360920297995, 4800.919793046536, 4958.975205123951, 4985.900281994413, 5026.899462010812, 5038.0, 5106.795728170831, 5148.897022059613, 5167.509086636764, 5171.844844654666, 5172.612054095883, 3812.3709587918793, 3994.7802870842384, 4112.9588704112575, 4212.041400748667, 4212.684048696298, 5680.358633235565, 5719.513841323368, 5731.0, 5757.453041961007, 5763.625364351304, 5457.717436402521, 5612.102063669793, 5616.045272303636, 5621.634593751393, 5625.803096891589, 5542.722863856871, 5557.5831812613405, 5559.972200138974, 5572.0, 5598.776048957996, 5519.972400137974, 5539.0, 5564.415736347787, 5573.383718721688, 5576.972115139399, 5441.374241962225, 5555.4167312200025, 5563.831595365019, 5596.440355964533, 5599.440055994368, 5449.1826226066405, 5450.31871016123, 5455.781768729206, 5477.1510415885605, 5502.944970550243], "value": 4125.871026985091, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [814.9266566009057, 830.3398797955625, 841.3815845353668, 845.7885528617845, 866.268003537011, 15155.772663410044, 15361.923190384061, 16201.703863690906, 16625.7506137408, 16649.0, 15131.621709457242, 15307.693846123071, 15309.617259568517, 15324.157171355571, 15326.693466130671, 676.8307923019245, 802.9598520074002, 812.540914383373, 834.2408408348405, 834.5743670727911, 821.0926925747053, 839.3117643532306, 840.1220724343076, 840.1514470384925, 840.3823189955378, 880.5289170293894, 882.3382463152635, 886.7916039730658, 887.0818702642766, 888.009868996068, 704.7603814703, 835.3484282259847, 849.6389034660244, 874.9431286966359, 883.0286684646901, 621.3599992008238, 625.2715586341906, 625.4808508937571, 626.3423405424286, 627.8461776864698, 15319.770203446957, 15342.616434589114, 15408.922955385264, 15440.382384704712, 15456.995295305882, 13961.79057314141, 13982.300884955814, 13984.440622375092, 14259.643508912257, 14289.142651440843, 12882.613521594367, 12884.549040783528, 13046.543370982065, 13079.607611771662, 13140.671483212996, 4488.932666010012, 4538.205813982573, 4627.421572303462, 4659.953400465985, 4700.835470758541, 75377.24622753757, 76030.61984690097, 76076.61961690211, 76700.0, 76787.61606191989, 10866.511007004703, 10939.83590246147, 11127.0, 11171.608993685344, 11644.41777911101, 20017.699734503993, 20021.899890500456, 20091.59816803656, 20123.39629811108, 20174.19303227884, 8106.270435660819, 8183.377669492603, 8253.95873020631, 8390.79023024417, 8520.914790852135, 4357.411749413788, 4438.0, 4595.287730401793, 4669.95330046702, 4820.517948205152, 3477.3045390921916, 3597.712183025404, 3598.3882739934274, 3602.963970360315, 3603.5855876574005, 467.32471578569323, 642.9389208025231, 645.4578154350369, 647.1683886206202, 648.2188962300511, 684.0628339175362, 739.548875186136, 753.8643044251978, 776.755322073545, 785.4148659248782, 10535.156347639286, 10692.198085143646, 10703.732406689895, 11005.494286738143, 11373.488193031333, 670.9396154346132, 697.0554898113085, 787.8384931089113, 794.1859593916166, 808.7209912580269, 4754.215554433549, 5127.230915362651, 5190.6366554341585, 5194.7922083116255, 5252.527272545412, 70067.64966175136, 75903.0, 109137.0, 111839.44080279546, 111879.44060279809, 61039.0, 88792.5560372194, 93773.0, 95379.0, 96046.51976740072, 56017.43982560122, 87105.12894871098, 87322.56338718266, 92043.53978230066, 92123.0, 9830.410175389214, 9906.851397228904, 9987.151092156957, 9996.45019523904, 10029.648962286285, 37338.0, 48320.275195871385, 49964.0, 50390.748046259534, 50490.24264636107, 69017.0, 69129.0, 75292.24707752852, 76269.61865190639, 77360.0, 12237.449314780679, 12275.324857132944, 12476.750464990831, 12649.873501265238, 12795.232286062866, 13892.791608126088, 14205.644858878612, 14224.644383890485, 14277.643058923195, 14690.192039437934, 13615.727685446434, 13651.11267767592, 13703.45186192541, 14391.208483533506, 14415.279236038366, 13301.733965320833, 13386.799198011842, 13451.865481345061, 13481.932590337377, 13527.120737152447, 13308.534201302908, 13469.0, 13476.326183690971, 13516.12145210558, 13587.660308492366, 11208.10335173168, 11280.307953806667, 11469.770604588028, 11566.826497602711, 11766.352850593299, 10369.1979972329, 10924.0, 11161.107111430903, 11268.38023908693, 11284.548618055185], "value": 7589.728387301482, "unit": "score"}], "name": "dromaeo_css", "value": 7282.578152998247, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 112.0, 110.0, 112.0, 112.0, 111.0, 113.0, 111.0, 111.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 122.0, 123.0, 170.0, 119.0, 120.0, 143.0, 118.0, 145.0, 117.0], "value": 132.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 161.0, 160.0, 159.0, 164.0, 160.0, 160.0, 160.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 74.0, 109.0, 74.0, 74.0, 79.0, 74.0, 100.0, 74.0], "value": 80.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 128.0, 83.0, 84.0, 83.0, 124.0, 83.0, 84.0, 133.0], "value": 97.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 146.0, 145.0, 147.0, 145.0, 146.0, 146.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 49.0, 50.0, 50.0, 49.0, 50.0, 50.0, 49.0, 51.0, 50.0], "value": 49.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 63.0, 63.0, 64.0, 64.0, 64.0, 63.0, 64.0], "value": 63.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 75.0, 81.0, 76.0, 78.0, 81.0, 75.0, 75.0, 74.0, 74.0], "value": 77.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 129.0, 119.0, 119.0, 116.0, 120.0, 119.0, 119.0, 160.0, 119.0], "value": 123.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 159.0, 154.0, 156.0, 158.0, 158.0, 157.0, 167.0, 159.0, 153.0], "value": 157.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 66.0, 62.0, 66.0, 70.0, 62.0, 61.0, 61.0, 64.0], "value": 63.9, "unit": "score"}], "name": "kraken", "value": 1474.9000000000003, "alertThreshold": 2.0}]} 05:06:49 INFO - Return code: 0 05:06:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:06:49 INFO - # TBPL SUCCESS # 05:06:49 INFO - Running post-action listener: _resource_record_post_action 05:06:49 INFO - ##### 05:06:49 INFO - ##### Finished run-tests step (success) 05:06:49 INFO - ##### 05:06:49 INFO - Running post-run listener: _resource_record_post_run 05:06:49 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 565391360; Read time: 0; Write time: 598452 05:06:49 INFO - TinderboxPrint: CPU usage
13.1% 05:06:49 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 05:06:49 INFO - TinderboxPrint: I/O write bytes / time
565,391,360 / 598,452 05:06:49 INFO - TinderboxPrint: CPU idle
8,266.8 (86.9%) 05:06:49 INFO - TinderboxPrint: CPU user
1,202.4 (12.6%) 05:06:49 INFO - TinderboxPrint: Swap in / out
0 / 0 05:06:49 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 268840960; Read time: 0; Write time: 320824 05:06:49 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 296247296; Read time: 0; Write time: 277624 05:06:49 INFO - Running post-run listener: _upload_blobber_files 05:06:49 INFO - Blob upload gear active. 05:06:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:06:49 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 05:06:49 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'] 05:06:49 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 05:06:50 INFO - (blobuploader) - INFO - Open directory for files ... 05:06:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:06:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:06:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:06:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:06:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:06:51 INFO - (blobuploader) - INFO - Done attempting. 05:06:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:06:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:06:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:06:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:06:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:06:55 INFO - (blobuploader) - INFO - Done attempting. 05:06:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:06:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:06:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:06:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:06:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:06:56 INFO - (blobuploader) - INFO - Done attempting. 05:06:56 INFO - (blobuploader) - INFO - Iteration through files over. 05:06:56 INFO - Return code: 0 05:06:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:06:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:06:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b71e05cbd553661cbff91f38a7cb62c3436b500116361984bcda5c1996635b937f9fb5780e406b69f987a71ae22c93cbc49fa865926aa55ac06811e00c9a0c32", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e69fc55ed3bf6ca2c9b4fff24af69f7ab1acd12443cf7a6c7d5222bbffd107e81c02da8758cc2c11e00f12db28839053481db22dc7f3fbc84993174930af58ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9c3de7f61b02ee0cecd2701934b0e07b0cfb367169c16d8ba2b10183629fbd30ae1948c5a7511337a489a107b9774a964bcf14abd9a541472a2f93d379f062d7"} 05:06:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:06:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:06:56 INFO - Contents: 05:06:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b71e05cbd553661cbff91f38a7cb62c3436b500116361984bcda5c1996635b937f9fb5780e406b69f987a71ae22c93cbc49fa865926aa55ac06811e00c9a0c32", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e69fc55ed3bf6ca2c9b4fff24af69f7ab1acd12443cf7a6c7d5222bbffd107e81c02da8758cc2c11e00f12db28839053481db22dc7f3fbc84993174930af58ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9c3de7f61b02ee0cecd2701934b0e07b0cfb367169c16d8ba2b10183629fbd30ae1948c5a7511337a489a107b9774a964bcf14abd9a541472a2f93d379f062d7"} 05:06:56 INFO - Running post-run listener: copy_logs_to_upload_dir 05:06:56 INFO - Copying logs to upload dir... 05:06:56 INFO - mkdir: /builds/slave/test/build/upload/logs 05:06:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.084321 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-07-18 05:06:56.896258) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 05:06:56.899819) ========= 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=a0d2d2de893abaa8702a9954000001a7-1468842384.90743-1060770222 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/b71e05cbd553661cbff91f38a7cb62c3436b500116361984bcda5c1996635b937f9fb5780e406b69f987a71ae22c93cbc49fa865926aa55ac06811e00c9a0c32", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e69fc55ed3bf6ca2c9b4fff24af69f7ab1acd12443cf7a6c7d5222bbffd107e81c02da8758cc2c11e00f12db28839053481db22dc7f3fbc84993174930af58ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9c3de7f61b02ee0cecd2701934b0e07b0cfb367169c16d8ba2b10183629fbd30ae1948c5a7511337a489a107b9774a964bcf14abd9a541472a2f93d379f062d7"} build_url:https://queue.taskcluster.net/v1/task/DRsE8QyhQp-Diue66PX13g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011130 build_url: 'https://queue.taskcluster.net/v1/task/DRsE8QyhQp-Diue66PX13g/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/b71e05cbd553661cbff91f38a7cb62c3436b500116361984bcda5c1996635b937f9fb5780e406b69f987a71ae22c93cbc49fa865926aa55ac06811e00c9a0c32", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e69fc55ed3bf6ca2c9b4fff24af69f7ab1acd12443cf7a6c7d5222bbffd107e81c02da8758cc2c11e00f12db28839053481db22dc7f3fbc84993174930af58ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9c3de7f61b02ee0cecd2701934b0e07b0cfb367169c16d8ba2b10183629fbd30ae1948c5a7511337a489a107b9774a964bcf14abd9a541472a2f93d379f062d7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 05:06:56.925324) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 05:06:56.925662) ========= 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=a0d2d2de893abaa8702a9954000001a7-1468842384.90743-1060770222 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004521 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 05:06:57.010286) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 05:06:57.010617) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 05:06:57.010953) ========= ========= Total master_lag: 0.17 =========