builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-023 starttime: 1472648030.97 results: success (0) buildid: 20160831030224 builduid: ddd4f3983d55401b901753c3e704c413 revision: 506facea63169a29e04eb140663da1730052db64 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-31 05:53:50.968265) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-31 05:53:50.968644) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-31 05:53:50.968916) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-31 05:53:51.186495) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 05:53:51.186770) ========= 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=6d15e502d8e29d5d2676d664000001c3-1472647112.30423-2040620460 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-31 05:53:52-- 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% 38.3M=0s 2016-08-31 05:53:52 (38.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.080411 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 05:53:51.306019) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 05:53:51.306373) ========= 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=6d15e502d8e29d5d2676d664000001c3-1472647112.30423-2040620460 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019846 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 05:53:51.357777) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 05:53:51.358120) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 506facea63169a29e04eb140663da1730052db64 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 506facea63169a29e04eb140663da1730052db64 --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=6d15e502d8e29d5d2676d664000001c3-1472647112.30423-2040620460 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-31 05:53:52,353 truncating revision to first 12 chars 2016-08-31 05:53:52,353 Setting DEBUG logging. 2016-08-31 05:53:52,353 attempt 1/10 2016-08-31 05:53:52,353 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/506facea6316?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-31 05:53:52,631 unpacking tar archive at: mozilla-central-506facea6316/testing/mozharness/ program finished with exit code 0 elapsedTime=0.559917 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 05:53:51.931346) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-31 05:53:51.931667) ========= script_repo_revision: 506facea63169a29e04eb140663da1730052db64 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-31 05:53:51.933619) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-31 05:53:51.933896) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-31 05:53:51.949356) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-08-31 05:53:51.949699) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=6d15e502d8e29d5d2676d664000001c3-1472647112.30423-2040620460 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:53:53 INFO - MultiFileLogger online at 20160831 05:53:53 in /builds/slave/test 05:53:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:53:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:53:53 INFO - {'append_to_log': False, 05:53:53 INFO - 'base_work_dir': '/builds/slave/test', 05:53:53 INFO - 'blob_upload_branch': 'Firefox', 05:53:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:53:53 INFO - 'branch': 'Firefox', 05:53:53 INFO - 'buildbot_json_path': 'buildprops.json', 05:53:53 INFO - 'config_files': ('talos/linux_config.py',), 05:53:53 INFO - 'default_actions': ('clobber', 05:53:53 INFO - 'read-buildbot-config', 05:53:53 INFO - 'download-and-extract', 05:53:53 INFO - 'populate-webroot', 05:53:53 INFO - 'create-virtualenv', 05:53:53 INFO - 'install', 05:53:53 INFO - 'run-tests'), 05:53:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:53:53 INFO - 'download_minidump_stackwalk': True, 05:53:53 INFO - 'download_symbols': 'ondemand', 05:53:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:53:53 INFO - 'tooltool.py': '/tools/tooltool.py', 05:53:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:53:53 INFO - '/tools/misc-python/virtualenv.py')}, 05:53:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:53:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:53:53 INFO - 'installer_path': 'installer.exe', 05:53:53 INFO - 'log_level': 'info', 05:53:53 INFO - 'log_name': 'talos', 05:53:53 INFO - 'log_to_console': True, 05:53:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:53:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:53:53 INFO - 'opt_config_files': (), 05:53:53 INFO - 'pip_index': False, 05:53:53 INFO - 'sps_profile': False, 05:53:53 INFO - 'sps_profile_interval': 0, 05:53:53 INFO - 'suite': 'dromaeojs', 05:53:53 INFO - 'system_bits': '32', 05:53:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:53:53 INFO - 'title': 'talos-linux64-ix-023', 05:53:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:53:53 INFO - 'use_talos_json': True, 05:53:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:53:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:53:53 INFO - 'work_dir': 'build'} 05:53:53 INFO - [mozharness: 2016-08-31 12:53:53.034747Z] Running clobber step. 05:53:53 INFO - Running pre-action listener: _resource_record_pre_action 05:53:53 INFO - Running main action method: clobber 05:53:53 INFO - rmtree: /builds/slave/test/build 05:53:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:53:53 INFO - Running post-action listener: _resource_record_post_action 05:53:53 INFO - [mozharness: 2016-08-31 12:53:53.497488Z] Finished clobber step (success) 05:53:53 INFO - [mozharness: 2016-08-31 12:53:53.497590Z] Running read-buildbot-config step. 05:53:53 INFO - Running pre-action listener: _resource_record_pre_action 05:53:53 INFO - Running main action method: read_buildbot_config 05:53:53 INFO - Using buildbot properties: 05:53:53 INFO - { 05:53:53 INFO - "project": "", 05:53:53 INFO - "product": "firefox", 05:53:53 INFO - "script_repo_revision": "production", 05:53:53 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:53:53 INFO - "repository": "", 05:53:53 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:53:53 INFO - "buildid": "20160831030224", 05:53:53 INFO - "stage_platform": "linux64-pgo", 05:53:53 INFO - "basedir": "/builds/slave/test", 05:53:53 INFO - "nightly_build": "True", 05:53:53 INFO - "buildnumber": 555, 05:53:53 INFO - "slavename": "talos-linux64-ix-023", 05:53:53 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:53:53 INFO - "platform": "ubuntu64_hw", 05:53:53 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:53:53 INFO - "branch": "mozilla-central", 05:53:53 INFO - "repo_path": "mozilla-central", 05:53:53 INFO - "revision": "506facea63169a29e04eb140663da1730052db64", 05:53:53 INFO - "pgo_build": "True", 05:53:53 INFO - "builduid": "ddd4f3983d55401b901753c3e704c413", 05:53:53 INFO - "slavebuilddir": "test" 05:53:53 INFO - } 05:53:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/dL9IlzjXSeKC2WcGUIOEnQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 05:53:53 INFO - Running post-action listener: _resource_record_post_action 05:53:53 INFO - [mozharness: 2016-08-31 12:53:53.500542Z] Finished read-buildbot-config step (success) 05:53:53 INFO - [mozharness: 2016-08-31 12:53:53.500641Z] Running download-and-extract step. 05:53:53 INFO - Running pre-action listener: _resource_record_pre_action 05:53:53 INFO - Running main action method: download_and_extract 05:53:53 INFO - mkdir: /builds/slave/test/build/tests 05:53:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:53 INFO - trying https://queue.taskcluster.net/v1/task/dL9IlzjXSeKC2WcGUIOEnQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:53:53 INFO - Downloading https://queue.taskcluster.net/v1/task/dL9IlzjXSeKC2WcGUIOEnQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:53:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dL9IlzjXSeKC2WcGUIOEnQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:53:54 INFO - Downloaded 1361 bytes. 05:53:54 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:53:54 INFO - Using the following test package requirements: 05:53:54 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 05:53:54 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:53:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:53:54 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:53:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:53:54 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:53:54 INFO - u'jsshell-linux-x86_64.zip'], 05:53:54 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:53:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:53:54 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 05:53:54 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:53:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:53:54 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:53:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:53:54 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:53:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:53:54 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:53:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:53:54 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:53:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:54 INFO - trying https://queue.taskcluster.net/v1/task/dL9IlzjXSeKC2WcGUIOEnQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:53:54 INFO - Downloading https://queue.taskcluster.net/v1/task/dL9IlzjXSeKC2WcGUIOEnQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:53:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dL9IlzjXSeKC2WcGUIOEnQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:53:54 INFO - Downloaded 21897022 bytes. 05:53:54 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 05:53:59 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:53:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:59 INFO - trying https://queue.taskcluster.net/v1/task/dL9IlzjXSeKC2WcGUIOEnQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:53:59 INFO - Downloading https://queue.taskcluster.net/v1/task/dL9IlzjXSeKC2WcGUIOEnQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:53:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dL9IlzjXSeKC2WcGUIOEnQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:53:59 INFO - Downloaded 21897022 bytes. 05:53:59 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 05:54:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:04 INFO - trying https://queue.taskcluster.net/v1/task/dL9IlzjXSeKC2WcGUIOEnQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 05:54:04 INFO - Downloading https://queue.taskcluster.net/v1/task/dL9IlzjXSeKC2WcGUIOEnQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 05:54:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dL9IlzjXSeKC2WcGUIOEnQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:54:06 INFO - Downloaded 14413998 bytes. 05:54:06 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 05:54:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:06 INFO - trying https://queue.taskcluster.net/v1/task/dL9IlzjXSeKC2WcGUIOEnQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:54:06 INFO - Downloading https://queue.taskcluster.net/v1/task/dL9IlzjXSeKC2WcGUIOEnQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:54:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dL9IlzjXSeKC2WcGUIOEnQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:54:08 INFO - Downloaded 59731076 bytes. 05:54:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dL9IlzjXSeKC2WcGUIOEnQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:54:08 INFO - mkdir: /builds/slave/test/properties 05:54:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:54:08 INFO - Writing to file /builds/slave/test/properties/build_url 05:54:08 INFO - Contents: 05:54:08 INFO - build_url:https://queue.taskcluster.net/v1/task/dL9IlzjXSeKC2WcGUIOEnQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:54:08 INFO - Running post-action listener: _resource_record_post_action 05:54:08 INFO - Running post-action listener: set_extra_try_arguments 05:54:08 INFO - [mozharness: 2016-08-31 12:54:08.955593Z] Finished download-and-extract step (success) 05:54:08 INFO - [mozharness: 2016-08-31 12:54:08.955821Z] Running populate-webroot step. 05:54:08 INFO - Running pre-action listener: _resource_record_pre_action 05:54:08 INFO - Running main action method: populate_webroot 05:54:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:54:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:54:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:54:08 INFO - '--tppagecycles', 05:54:08 INFO - '7'], 05:54:08 INFO - 'tests': ['tsvgm']}}, 05:54:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:54:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:54:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:54:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:54:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:54:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:54:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:08 INFO - 'talos_options': ['--disable-e10s'], 05:54:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:54:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:54:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:08 INFO - 'talos_options': ['--disable-e10s'], 05:54:08 INFO - 'tests': ['damp', 'tps']}, 05:54:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:08 INFO - 'tests': ['damp', 'tps']}, 05:54:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:54:08 INFO - 'tests': ['dromaeo_dom']}, 05:54:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:54:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:54:08 INFO - 'tests': ['basic_compositor_video']}, 05:54:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:54:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:54:08 INFO - 'tests': ['a11yr', 05:54:08 INFO - 'ts_paint', 05:54:08 INFO - 'tpaint', 05:54:08 INFO - 'sessionrestore', 05:54:08 INFO - 'sessionrestore_no_auto_restore', 05:54:08 INFO - 'tabpaint']}, 05:54:08 INFO - 'other-e10s': {'tests': ['a11yr', 05:54:08 INFO - 'ts_paint', 05:54:08 INFO - 'tpaint', 05:54:08 INFO - 'sessionrestore', 05:54:08 INFO - 'sessionrestore_no_auto_restore', 05:54:08 INFO - 'tabpaint']}, 05:54:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:54:08 INFO - 'ts_paint', 05:54:08 INFO - 'tpaint', 05:54:08 INFO - 'sessionrestore', 05:54:08 INFO - 'sessionrestore_no_auto_restore', 05:54:08 INFO - 'tabpaint']}, 05:54:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:54:08 INFO - 'ts_paint', 05:54:08 INFO - 'tpaint', 05:54:08 INFO - 'sessionrestore', 05:54:08 INFO - 'sessionrestore_no_auto_restore', 05:54:08 INFO - 'tabpaint']}, 05:54:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:54:08 INFO - 'tests': ['a11yr', 05:54:08 INFO - 'ts_paint', 05:54:08 INFO - 'tpaint', 05:54:08 INFO - 'sessionrestore', 05:54:08 INFO - 'sessionrestore_no_auto_restore', 05:54:08 INFO - 'tabpaint']}, 05:54:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:54:08 INFO - 'tests': ['a11yr', 05:54:08 INFO - 'ts_paint', 05:54:08 INFO - 'tpaint', 05:54:08 INFO - 'sessionrestore', 05:54:08 INFO - 'sessionrestore_no_auto_restore', 05:54:08 INFO - 'tabpaint']}, 05:54:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:54:08 INFO - 'tests': ['tsvgx', 05:54:08 INFO - 'tsvgr_opacity', 05:54:08 INFO - 'tart', 05:54:08 INFO - 'tscrollx', 05:54:08 INFO - 'cart']}, 05:54:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:54:08 INFO - 'tsvgr_opacity', 05:54:08 INFO - 'tart', 05:54:08 INFO - 'tscrollx', 05:54:08 INFO - 'cart']}, 05:54:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:08 INFO - 'talos_options': ['--disable-e10s'], 05:54:08 INFO - 'tests': ['tp5o']}, 05:54:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:08 INFO - 'tests': ['tp5o']}, 05:54:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:08 INFO - 'talos_options': ['--disable-e10s', 05:54:08 INFO - '--xperf_path', 05:54:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:54:08 INFO - 'tests': ['tp5n']}, 05:54:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:08 INFO - 'talos_options': ['--xperf_path', 05:54:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:54:08 INFO - 'tests': ['tp5n']}}, 05:54:08 INFO - 'talos.zip': {'path': '', 05:54:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:54:08 INFO - Running post-action listener: _resource_record_post_action 05:54:08 INFO - [mozharness: 2016-08-31 12:54:08.977834Z] Finished populate-webroot step (success) 05:54:08 INFO - [mozharness: 2016-08-31 12:54:08.977924Z] Running create-virtualenv step. 05:54:08 INFO - Running pre-action listener: _resource_record_pre_action 05:54:08 INFO - Running main action method: create_virtualenv 05:54:08 INFO - Creating virtualenv /builds/slave/test/build/venv 05:54:08 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:54:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:54:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:54:09 INFO - Using real prefix '/usr' 05:54:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:54:09 INFO - Installing distribute.............................................................................................................................................................................................done. 05:54:11 INFO - Installing pip.................done. 05:54:11 INFO - Return code: 0 05:54:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:54:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2d1f16df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x175b850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1756370>, '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 0x17598f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1759d80>, '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': '6d15e502d8e29d5d2676d664000001c3-1472647112.30423-2040620460', '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 05:54:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:54:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:54:11 INFO - Using env: {'DISPLAY': ':0', 05:54:11 INFO - 'HOME': '/home/cltbld', 05:54:11 INFO - 'LANG': 'en_US.UTF-8', 05:54:11 INFO - 'LANGUAGE': 'en_US:en', 05:54:11 INFO - 'LOGNAME': 'cltbld', 05:54:11 INFO - 'MAIL': '/var/mail/cltbld', 05:54:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:11 INFO - 'MOZ_NO_REMOTE': '1', 05:54:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:11 INFO - 'NO_EM_RESTART': '1', 05:54:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:11 INFO - 'PWD': '/builds/slave/test', 05:54:11 INFO - 'SHELL': '/bin/bash', 05:54:11 INFO - 'SHLVL': '1', 05:54:11 INFO - 'TERM': 'linux', 05:54:11 INFO - 'TMOUT': '86400', 05:54:11 INFO - 'USER': 'cltbld', 05:54:11 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1472647112.30423-2040620460', 05:54:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:11 INFO - '_': '/tools/buildbot/bin/python'} 05:54:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:11 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:54:11 INFO - Cleaning up... 05:54:11 INFO - Return code: 0 05:54:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:54:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2d1f16df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x175b850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1756370>, '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 0x17598f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1759d80>, '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': '6d15e502d8e29d5d2676d664000001c3-1472647112.30423-2040620460', '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 05:54:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:54:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:54:11 INFO - Using env: {'DISPLAY': ':0', 05:54:11 INFO - 'HOME': '/home/cltbld', 05:54:11 INFO - 'LANG': 'en_US.UTF-8', 05:54:11 INFO - 'LANGUAGE': 'en_US:en', 05:54:11 INFO - 'LOGNAME': 'cltbld', 05:54:11 INFO - 'MAIL': '/var/mail/cltbld', 05:54:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:11 INFO - 'MOZ_NO_REMOTE': '1', 05:54:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:11 INFO - 'NO_EM_RESTART': '1', 05:54:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:11 INFO - 'PWD': '/builds/slave/test', 05:54:11 INFO - 'SHELL': '/bin/bash', 05:54:11 INFO - 'SHLVL': '1', 05:54:11 INFO - 'TERM': 'linux', 05:54:11 INFO - 'TMOUT': '86400', 05:54:11 INFO - 'USER': 'cltbld', 05:54:11 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1472647112.30423-2040620460', 05:54:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:11 INFO - '_': '/tools/buildbot/bin/python'} 05:54:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:11 INFO - Downloading/unpacking psutil>=3.1.1 05:54:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:54:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:54:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:54:13 INFO - Installing collected packages: psutil 05:54:13 INFO - Running setup.py install for psutil 05:54:14 INFO - building 'psutil._psutil_linux' extension 05:54:14 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 05:54:14 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:54:14 INFO - building 'psutil._psutil_posix' extension 05:54:14 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 05:54:14 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:54:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:54:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:54:14 INFO - Successfully installed psutil 05:54:14 INFO - Cleaning up... 05:54:14 INFO - Return code: 0 05:54:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:54:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2d1f16df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x175b850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1756370>, '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 0x17598f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1759d80>, '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': '6d15e502d8e29d5d2676d664000001c3-1472647112.30423-2040620460', '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 05:54:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:54:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:54:14 INFO - Using env: {'DISPLAY': ':0', 05:54:14 INFO - 'HOME': '/home/cltbld', 05:54:14 INFO - 'LANG': 'en_US.UTF-8', 05:54:14 INFO - 'LANGUAGE': 'en_US:en', 05:54:14 INFO - 'LOGNAME': 'cltbld', 05:54:14 INFO - 'MAIL': '/var/mail/cltbld', 05:54:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:14 INFO - 'MOZ_NO_REMOTE': '1', 05:54:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:14 INFO - 'NO_EM_RESTART': '1', 05:54:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:14 INFO - 'PWD': '/builds/slave/test', 05:54:14 INFO - 'SHELL': '/bin/bash', 05:54:14 INFO - 'SHLVL': '1', 05:54:14 INFO - 'TERM': 'linux', 05:54:14 INFO - 'TMOUT': '86400', 05:54:14 INFO - 'USER': 'cltbld', 05:54:14 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1472647112.30423-2040620460', 05:54:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:14 INFO - '_': '/tools/buildbot/bin/python'} 05:54:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:54:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:54:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:54:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:54:16 INFO - Installing collected packages: mozsystemmonitor 05:54:16 INFO - Running setup.py install for mozsystemmonitor 05:54:16 INFO - Successfully installed mozsystemmonitor 05:54:16 INFO - Cleaning up... 05:54:16 INFO - Return code: 0 05:54:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:54:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2d1f16df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x175b850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1756370>, '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 0x17598f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1759d80>, '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': '6d15e502d8e29d5d2676d664000001c3-1472647112.30423-2040620460', '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 05:54:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:54:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:54:16 INFO - Using env: {'DISPLAY': ':0', 05:54:16 INFO - 'HOME': '/home/cltbld', 05:54:16 INFO - 'LANG': 'en_US.UTF-8', 05:54:16 INFO - 'LANGUAGE': 'en_US:en', 05:54:16 INFO - 'LOGNAME': 'cltbld', 05:54:16 INFO - 'MAIL': '/var/mail/cltbld', 05:54:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:16 INFO - 'MOZ_NO_REMOTE': '1', 05:54:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:16 INFO - 'NO_EM_RESTART': '1', 05:54:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:16 INFO - 'PWD': '/builds/slave/test', 05:54:16 INFO - 'SHELL': '/bin/bash', 05:54:16 INFO - 'SHLVL': '1', 05:54:16 INFO - 'TERM': 'linux', 05:54:16 INFO - 'TMOUT': '86400', 05:54:16 INFO - 'USER': 'cltbld', 05:54:16 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1472647112.30423-2040620460', 05:54:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:16 INFO - '_': '/tools/buildbot/bin/python'} 05:54:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:16 INFO - Downloading/unpacking jsonschema==2.5.1 05:54:17 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 05:54:17 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 05:54:17 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 05:54:17 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 05:54:17 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 05:54:17 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 05:54:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:54:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:54:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:19 INFO - Downloading functools32-3.2.3-2.tar.gz 05:54:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:54:19 INFO - warning: no files found matching '*.txt' 05:54:19 INFO - no previously-included directories found matching 'build' 05:54:19 INFO - no previously-included directories found matching 'dist' 05:54:19 INFO - no previously-included directories found matching '.git*' 05:54:19 INFO - Installing collected packages: jsonschema, functools32 05:54:19 INFO - Running setup.py install for functools32 05:54:19 INFO - warning: no files found matching '*.txt' 05:54:19 INFO - no previously-included directories found matching 'build' 05:54:19 INFO - no previously-included directories found matching 'dist' 05:54:19 INFO - no previously-included directories found matching '.git*' 05:54:19 INFO - Successfully installed jsonschema functools32 05:54:19 INFO - Cleaning up... 05:54:19 INFO - Return code: 0 05:54:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:54:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2d1f16df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x175b850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1756370>, '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 0x17598f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1759d80>, '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': '6d15e502d8e29d5d2676d664000001c3-1472647112.30423-2040620460', '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 05:54:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:54:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:54:19 INFO - Using env: {'DISPLAY': ':0', 05:54:19 INFO - 'HOME': '/home/cltbld', 05:54:19 INFO - 'LANG': 'en_US.UTF-8', 05:54:19 INFO - 'LANGUAGE': 'en_US:en', 05:54:19 INFO - 'LOGNAME': 'cltbld', 05:54:19 INFO - 'MAIL': '/var/mail/cltbld', 05:54:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:19 INFO - 'MOZ_NO_REMOTE': '1', 05:54:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:19 INFO - 'NO_EM_RESTART': '1', 05:54:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:19 INFO - 'PWD': '/builds/slave/test', 05:54:19 INFO - 'SHELL': '/bin/bash', 05:54:19 INFO - 'SHLVL': '1', 05:54:19 INFO - 'TERM': 'linux', 05:54:19 INFO - 'TMOUT': '86400', 05:54:19 INFO - 'USER': 'cltbld', 05:54:19 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1472647112.30423-2040620460', 05:54:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:19 INFO - '_': '/tools/buildbot/bin/python'} 05:54:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:54:19 INFO - Cleaning up... 05:54:19 INFO - Return code: 0 05:54:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:54:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2d1f16df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x175b850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1756370>, '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 0x17598f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1759d80>, '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': '6d15e502d8e29d5d2676d664000001c3-1472647112.30423-2040620460', '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 05:54:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:54:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:54:19 INFO - Using env: {'DISPLAY': ':0', 05:54:19 INFO - 'HOME': '/home/cltbld', 05:54:19 INFO - 'LANG': 'en_US.UTF-8', 05:54:19 INFO - 'LANGUAGE': 'en_US:en', 05:54:19 INFO - 'LOGNAME': 'cltbld', 05:54:19 INFO - 'MAIL': '/var/mail/cltbld', 05:54:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:19 INFO - 'MOZ_NO_REMOTE': '1', 05:54:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:19 INFO - 'NO_EM_RESTART': '1', 05:54:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:19 INFO - 'PWD': '/builds/slave/test', 05:54:19 INFO - 'SHELL': '/bin/bash', 05:54:19 INFO - 'SHLVL': '1', 05:54:19 INFO - 'TERM': 'linux', 05:54:19 INFO - 'TMOUT': '86400', 05:54:19 INFO - 'USER': 'cltbld', 05:54:19 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1472647112.30423-2040620460', 05:54:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:19 INFO - '_': '/tools/buildbot/bin/python'} 05:54:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:19 INFO - Downloading/unpacking blobuploader==1.2.4 05:54:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:21 INFO - Downloading blobuploader-1.2.4.tar.gz 05:54:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:54:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:54:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:54:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:54:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:22 INFO - Downloading docopt-0.6.1.tar.gz 05:54:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:54:22 INFO - Installing collected packages: blobuploader, requests, docopt 05:54:22 INFO - Running setup.py install for blobuploader 05:54:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:54:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:54:22 INFO - Running setup.py install for requests 05:54:22 INFO - Running setup.py install for docopt 05:54:23 INFO - Successfully installed blobuploader requests docopt 05:54:23 INFO - Cleaning up... 05:54:23 INFO - Return code: 0 05:54:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:54:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:23 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 0x7f2d1f16df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x175b850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1756370>, '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 0x17598f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1759d80>, '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': '6d15e502d8e29d5d2676d664000001c3-1472647112.30423-2040620460', '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 05:54:23 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 05:54:23 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 05:54:23 INFO - Using env: {'DISPLAY': ':0', 05:54:23 INFO - 'HOME': '/home/cltbld', 05:54:23 INFO - 'LANG': 'en_US.UTF-8', 05:54:23 INFO - 'LANGUAGE': 'en_US:en', 05:54:23 INFO - 'LOGNAME': 'cltbld', 05:54:23 INFO - 'MAIL': '/var/mail/cltbld', 05:54:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:23 INFO - 'MOZ_NO_REMOTE': '1', 05:54:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:23 INFO - 'NO_EM_RESTART': '1', 05:54:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:23 INFO - 'PWD': '/builds/slave/test', 05:54:23 INFO - 'SHELL': '/bin/bash', 05:54:23 INFO - 'SHLVL': '1', 05:54:23 INFO - 'TERM': 'linux', 05:54:23 INFO - 'TMOUT': '86400', 05:54:23 INFO - 'USER': 'cltbld', 05:54:23 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1472647112.30423-2040620460', 05:54:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:23 INFO - '_': '/tools/buildbot/bin/python'} 05:54:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:54:23 INFO - Running setup.py (path:/tmp/pip-HbNZej-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:54:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:54:23 INFO - Running setup.py (path:/tmp/pip-xqy5fF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:54:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:54:23 INFO - Running setup.py (path:/tmp/pip-7RdB3H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:54:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:54:23 INFO - Running setup.py (path:/tmp/pip-6LVK0C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:54:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:54:23 INFO - Running setup.py (path:/tmp/pip-wot6ek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:54:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:54:23 INFO - Running setup.py (path:/tmp/pip-5YL_ar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:54:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:54:23 INFO - Running setup.py (path:/tmp/pip-PjIg1e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:54:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:54:23 INFO - Running setup.py (path:/tmp/pip-VVlYRJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:54:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:54:23 INFO - Running setup.py (path:/tmp/pip-kMLW0V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:54:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:54:23 INFO - Running setup.py (path:/tmp/pip-yzhzo6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:54:24 INFO - Running setup.py (path:/tmp/pip-U6ZQTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:54:24 INFO - Running setup.py (path:/tmp/pip-F_1jsb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:54:24 INFO - Running setup.py (path:/tmp/pip-KyjKiW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:54:24 INFO - Running setup.py (path:/tmp/pip-zvpLI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:54:24 INFO - Running setup.py (path:/tmp/pip-1mlpgz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:54:24 INFO - Running setup.py (path:/tmp/pip-t817uo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:54:24 INFO - Running setup.py (path:/tmp/pip-eU6siT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:54:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:54:24 INFO - Running setup.py install for manifestparser 05:54:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:54:24 INFO - Running setup.py install for mozcrash 05:54:24 INFO - Running setup.py install for mozdebug 05:54:24 INFO - Running setup.py install for mozdevice 05:54:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:54:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:54:24 INFO - Running setup.py install for mozfile 05:54:25 INFO - Running setup.py install for mozhttpd 05:54:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:54:25 INFO - Running setup.py install for mozinfo 05:54:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:54:25 INFO - Running setup.py install for mozInstall 05:54:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:54:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:54:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:54:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:54:25 INFO - Running setup.py install for mozleak 05:54:25 INFO - Running setup.py install for mozlog 05:54:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:54:25 INFO - Running setup.py install for moznetwork 05:54:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:54:25 INFO - Running setup.py install for mozprocess 05:54:25 INFO - Running setup.py install for mozprofile 05:54:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:54:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:54:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:54:25 INFO - Running setup.py install for mozrunner 05:54:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:54:26 INFO - Running setup.py install for mozscreenshot 05:54:26 INFO - Running setup.py install for moztest 05:54:26 INFO - Running setup.py install for mozversion 05:54:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:54:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:54:26 INFO - Cleaning up... 05:54:26 INFO - Return code: 0 05:54:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:54:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2d1f16df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x175b850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1756370>, '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 0x17598f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1759d80>, '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': '6d15e502d8e29d5d2676d664000001c3-1472647112.30423-2040620460', '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 05:54:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:54:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:54:26 INFO - Using env: {'DISPLAY': ':0', 05:54:26 INFO - 'HOME': '/home/cltbld', 05:54:26 INFO - 'LANG': 'en_US.UTF-8', 05:54:26 INFO - 'LANGUAGE': 'en_US:en', 05:54:26 INFO - 'LOGNAME': 'cltbld', 05:54:26 INFO - 'MAIL': '/var/mail/cltbld', 05:54:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:26 INFO - 'MOZ_NO_REMOTE': '1', 05:54:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:26 INFO - 'NO_EM_RESTART': '1', 05:54:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:26 INFO - 'PWD': '/builds/slave/test', 05:54:26 INFO - 'SHELL': '/bin/bash', 05:54:26 INFO - 'SHLVL': '1', 05:54:26 INFO - 'TERM': 'linux', 05:54:26 INFO - 'TMOUT': '86400', 05:54:26 INFO - 'USER': 'cltbld', 05:54:26 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1472647112.30423-2040620460', 05:54:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:26 INFO - '_': '/tools/buildbot/bin/python'} 05:54:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:54:26 INFO - Running setup.py (path:/tmp/pip-CQCuWq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:54:26 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:54:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:54:26 INFO - Running setup.py (path:/tmp/pip-irbK4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:54:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:54:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:54:26 INFO - Running setup.py (path:/tmp/pip-S5B2h7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:54:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:54:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:54:26 INFO - Running setup.py (path:/tmp/pip-9NP0rc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:54:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:54:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:54:26 INFO - Running setup.py (path:/tmp/pip-9tfdNI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:54:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:54:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:54:26 INFO - Running setup.py (path:/tmp/pip-jGbubP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:54:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:54:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:54:26 INFO - Running setup.py (path:/tmp/pip-mITXZi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:54:27 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)) 05:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:54:27 INFO - Running setup.py (path:/tmp/pip-eEgqS8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:54:27 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)) 05:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:54:27 INFO - Running setup.py (path:/tmp/pip-nz3QsG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:54:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:54:27 INFO - Running setup.py (path:/tmp/pip-xUn1GX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:54:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:54:27 INFO - Running setup.py (path:/tmp/pip-ZN6Qpf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:54:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:54:27 INFO - Running setup.py (path:/tmp/pip-lHwWR4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:54:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:54:27 INFO - Running setup.py (path:/tmp/pip-AMC9Eq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:54:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:54:27 INFO - Running setup.py (path:/tmp/pip-oycXP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:54:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:54:27 INFO - Running setup.py (path:/tmp/pip-jwVNH3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:54:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:54:27 INFO - Running setup.py (path:/tmp/pip-L_pSCW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:54:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:54:27 INFO - Running setup.py (path:/tmp/pip-IXnZjY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:54:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:54:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:54:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:54:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:54:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:54:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:54:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:54:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:29 INFO - Downloading blessings-1.6.tar.gz 05:54:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:54:29 INFO - Installing collected packages: blessings 05:54:29 INFO - Running setup.py install for blessings 05:54:29 INFO - Successfully installed blessings 05:54:29 INFO - Cleaning up... 05:54:29 INFO - Return code: 0 05:54:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:54:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:54:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:54:30 INFO - Reading from file tmpfile_stdout 05:54:30 INFO - Current package versions: 05:54:30 INFO - argparse == 1.2.1 05:54:30 INFO - blessings == 1.6 05:54:30 INFO - blobuploader == 1.2.4 05:54:30 INFO - docopt == 0.6.1 05:54:30 INFO - functools32 == 3.2.3-2 05:54:30 INFO - jsonschema == 2.5.1 05:54:30 INFO - manifestparser == 1.1 05:54:30 INFO - mozInstall == 1.12 05:54:30 INFO - mozcrash == 0.17 05:54:30 INFO - mozdebug == 0.1 05:54:30 INFO - mozdevice == 0.48 05:54:30 INFO - mozfile == 1.2 05:54:30 INFO - mozhttpd == 0.7 05:54:30 INFO - mozinfo == 0.9 05:54:30 INFO - mozleak == 0.1 05:54:30 INFO - mozlog == 3.3 05:54:30 INFO - moznetwork == 0.27 05:54:30 INFO - mozprocess == 0.23 05:54:30 INFO - mozprofile == 0.28 05:54:30 INFO - mozrunner == 6.12 05:54:30 INFO - mozscreenshot == 0.1 05:54:30 INFO - mozsystemmonitor == 0.3 05:54:30 INFO - moztest == 0.7 05:54:30 INFO - mozversion == 1.4 05:54:30 INFO - psutil == 3.1.1 05:54:30 INFO - requests == 1.2.3 05:54:30 INFO - wsgiref == 0.1.2 05:54:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:54:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2d1f16df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x175b850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1756370>, '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 0x17598f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1759d80>, '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': '6d15e502d8e29d5d2676d664000001c3-1472647112.30423-2040620460', '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 05:54:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:54:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:54:30 INFO - Using env: {'DISPLAY': ':0', 05:54:30 INFO - 'HOME': '/home/cltbld', 05:54:30 INFO - 'LANG': 'en_US.UTF-8', 05:54:30 INFO - 'LANGUAGE': 'en_US:en', 05:54:30 INFO - 'LOGNAME': 'cltbld', 05:54:30 INFO - 'MAIL': '/var/mail/cltbld', 05:54:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:30 INFO - 'MOZ_NO_REMOTE': '1', 05:54:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:30 INFO - 'NO_EM_RESTART': '1', 05:54:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:30 INFO - 'PWD': '/builds/slave/test', 05:54:30 INFO - 'SHELL': '/bin/bash', 05:54:30 INFO - 'SHLVL': '1', 05:54:30 INFO - 'TERM': 'linux', 05:54:30 INFO - 'TMOUT': '86400', 05:54:30 INFO - 'USER': 'cltbld', 05:54:30 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1472647112.30423-2040620460', 05:54:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:30 INFO - '_': '/tools/buildbot/bin/python'} 05:54:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:54:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:54:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:54:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:54:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:54:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:54:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:54:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:54:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:54:30 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:54:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:54:30 INFO - Cleaning up... 05:54:30 INFO - Return code: 0 05:54:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:54:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2d1f16df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x175b850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1756370>, '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 0x17598f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1759d80>, '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': '6d15e502d8e29d5d2676d664000001c3-1472647112.30423-2040620460', '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 05:54:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:54:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:54:30 INFO - Using env: {'DISPLAY': ':0', 05:54:30 INFO - 'HOME': '/home/cltbld', 05:54:30 INFO - 'LANG': 'en_US.UTF-8', 05:54:30 INFO - 'LANGUAGE': 'en_US:en', 05:54:30 INFO - 'LOGNAME': 'cltbld', 05:54:30 INFO - 'MAIL': '/var/mail/cltbld', 05:54:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:30 INFO - 'MOZ_NO_REMOTE': '1', 05:54:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:30 INFO - 'NO_EM_RESTART': '1', 05:54:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:30 INFO - 'PWD': '/builds/slave/test', 05:54:30 INFO - 'SHELL': '/bin/bash', 05:54:30 INFO - 'SHLVL': '1', 05:54:30 INFO - 'TERM': 'linux', 05:54:30 INFO - 'TMOUT': '86400', 05:54:30 INFO - 'USER': 'cltbld', 05:54:30 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1472647112.30423-2040620460', 05:54:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:30 INFO - '_': '/tools/buildbot/bin/python'} 05:54:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:54:30 INFO - Cleaning up... 05:54:30 INFO - Return code: 0 05:54:30 INFO - Running post-action listener: _resource_record_post_action 05:54:30 INFO - Running post-action listener: _start_resource_monitoring 05:54:30 INFO - Starting resource monitoring. 05:54:30 INFO - [mozharness: 2016-08-31 12:54:30.658543Z] Finished create-virtualenv step (success) 05:54:30 INFO - [mozharness: 2016-08-31 12:54:30.659057Z] Running install step. 05:54:30 INFO - Running pre-action listener: _resource_record_pre_action 05:54:30 INFO - Running main action method: install 05:54:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:54:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:54:30 INFO - Reading from file tmpfile_stdout 05:54:30 INFO - Detecting whether we're running mozinstall >=1.0... 05:54:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:54:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:54:30 INFO - Reading from file tmpfile_stdout 05:54:30 INFO - Output received: 05:54:30 INFO - Usage: mozinstall [options] installer 05:54:30 INFO - Options: 05:54:30 INFO - -h, --help show this help message and exit 05:54:30 INFO - -d DEST, --destination=DEST 05:54:30 INFO - Directory to install application into. [default: 05:54:30 INFO - "/builds/slave/test"] 05:54:30 INFO - --app=APP Application being installed. [default: firefox] 05:54:30 INFO - mkdir: /builds/slave/test/build/application 05:54:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:54:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:54:47 INFO - Reading from file tmpfile_stdout 05:54:47 INFO - Output received: 05:54:47 INFO - /builds/slave/test/build/application/firefox/firefox 05:54:47 INFO - Running post-action listener: _resource_record_post_action 05:54:47 INFO - [mozharness: 2016-08-31 12:54:47.955134Z] Finished install step (success) 05:54:47 INFO - [mozharness: 2016-08-31 12:54:47.955416Z] Running run-tests step. 05:54:47 INFO - Running pre-action listener: _resource_record_pre_action 05:54:47 INFO - Running main action method: run_tests 05:54:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:54:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:54:47 INFO - Python 2.7.3 05:54:47 INFO - Return code: 0 05:54:47 INFO - grabbing minidump binary from tooltool 05:54:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:47 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1756370>, '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 0x17598f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1759d80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:54:47 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:54:47 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:54:47 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:54:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:54:48 INFO - Return code: 0 05:54:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:54:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:54:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:54:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:54:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:54:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dL9IlzjXSeKC2WcGUIOEnQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 05:54:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dL9IlzjXSeKC2WcGUIOEnQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --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 05:54:48 INFO - Using env: {'DISPLAY': ':0', 05:54:48 INFO - 'HOME': '/home/cltbld', 05:54:48 INFO - 'LANG': 'en_US.UTF-8', 05:54:48 INFO - 'LANGUAGE': 'en_US:en', 05:54:48 INFO - 'LOGNAME': 'cltbld', 05:54:48 INFO - 'MAIL': '/var/mail/cltbld', 05:54:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:54:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:54:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:48 INFO - 'MOZ_NO_REMOTE': '1', 05:54:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:54:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:48 INFO - 'NO_EM_RESTART': '1', 05:54:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:48 INFO - 'PWD': '/builds/slave/test', 05:54:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:54:48 INFO - 'SHELL': '/bin/bash', 05:54:48 INFO - 'SHLVL': '1', 05:54:48 INFO - 'TERM': 'linux', 05:54:48 INFO - 'TMOUT': '86400', 05:54:48 INFO - 'USER': 'cltbld', 05:54:48 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1472647112.30423-2040620460', 05:54:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:48 INFO - '_': '/tools/buildbot/bin/python'} 05:54:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dL9IlzjXSeKC2WcGUIOEnQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 05:54:48 INFO - mozversion application_buildid: 20160831030224 05:54:48 INFO - mozversion application_changeset: 506facea63169a29e04eb140663da1730052db64 05:54:48 INFO - mozversion application_display_name: Nightly 05:54:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:54:48 INFO - mozversion application_name: Firefox 05:54:48 INFO - mozversion application_remotingname: firefox 05:54:48 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:54:48 INFO - mozversion application_vendor: Mozilla 05:54:48 INFO - mozversion application_version: 51.0a1 05:54:48 INFO - mozversion platform_buildid: 20160831030224 05:54:48 INFO - mozversion platform_changeset: 506facea63169a29e04eb140663da1730052db64 05:54:48 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:54:48 INFO - mozversion platform_version: 51.0a1 05:54:48 INFO - using testdate: 1472648088 05:54:48 INFO - actual date: 1472648088 05:54:48 INFO - starting webserver on 'localhost:57236' 05:54:48 INFO - SUITE-START | Running 2 tests 05:54:48 INFO - TEST-START | dromaeo_css 05:54:48 INFO - operating with platform_type : linux_ 05:54:48 INFO - Initialising browser for dromaeo_css test... 05:54:48 INFO - TEST-INFO | started process 29633 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK7Jsdc/profile http://localhost:57236/getInfo.html) 05:54:52 INFO - PROCESS | 29633 | __metrics Screen width/height:1600/1200 05:54:52 INFO - PROCESS | 29633 | colorDepth:24 05:54:52 INFO - PROCESS | 29633 | Browser inner width/height: 1024/697 05:54:52 INFO - PROCESS | 29633 | __metrics 05:54:52 INFO - PROCESS | 29633 | 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:54:52 INFO - PROCESS | 29633 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:54:53 INFO - PROCESS | 29633 | console.error: PushService: 05:54:53 INFO - PROCESS | 29633 | stateChangeProcessEnqueue: Error transitioning state 05:54:53 INFO - PROCESS | 29633 | UnknownError 05:54:54 INFO - TEST-INFO | 29633: exit 0 05:54:54 INFO - Browser initialized. 05:54:54 INFO - Running cycle 1/1 for dromaeo_css test... 05:54:54 INFO - TEST-INFO | started process 29714 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK7Jsdc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:55:06 INFO - PROCESS | 29714 | RSS: Main: 180084736 05:55:06 INFO - PROCESS | 29714 | 05:55:57 INFO - PROCESS | 29714 | 1472648157753 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] 05:58:06 INFO - PROCESS | 29714 | Cycle 1(1): loaded http://localhost:57236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57236/tests/dromaeo/cssquery-ext.html) 05:58:07 INFO - PROCESS | 29714 | RSS: Main: 301248512 05:58:07 INFO - PROCESS | 29714 | 06:01:10 INFO - PROCESS | 29714 | Cycle 1(1): loaded http://localhost:57236/tests/dromaeo/cssquery-ext.html (next: http://localhost:57236/tests/dromaeo/cssquery-jquery.html) 06:01:10 INFO - PROCESS | 29714 | RSS: Main: 267587584 06:01:10 INFO - PROCESS | 29714 | 06:04:13 INFO - PROCESS | 29714 | Cycle 1(1): loaded http://localhost:57236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57236/tests/dromaeo/cssquery-mootools.html) 06:04:13 INFO - PROCESS | 29714 | RSS: Main: 240254976 06:04:13 INFO - PROCESS | 29714 | 06:07:15 INFO - PROCESS | 29714 | Cycle 1(1): loaded http://localhost:57236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57236/tests/dromaeo/cssquery-prototype.html) 06:07:16 INFO - PROCESS | 29714 | RSS: Main: 220966912 06:07:16 INFO - PROCESS | 29714 | 06:10:19 INFO - PROCESS | 29714 | Cycle 1(1): loaded http://localhost:57236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57236/tests/dromaeo/cssquery-yui.html) 06:10:19 INFO - PROCESS | 29714 | RSS: Main: 214802432 06:10:19 INFO - PROCESS | 29714 | 06:13:22 INFO - PROCESS | 29714 | Cycle 1(1): loaded http://localhost:57236/tests/dromaeo/cssquery-yui.html (next: http://localhost:57236/tests/dromaeo/cssquery-dojo.html) 06:13:22 INFO - PROCESS | 29714 | RSS: Main: 305815552 06:13:22 INFO - PROCESS | 29714 | 06:13:22 INFO - PROCESS | 29714 | __start_tp_report 06:13:22 INFO - PROCESS | 29714 | _x_x_mozilla_page_load 06:13:22 INFO - PROCESS | 29714 | _x_x_mozilla_page_load_details 06:13:22 INFO - PROCESS | 29714 | |i|pagename|runs| 06:13:22 INFO - PROCESS | 29714 | |0;dojo.html;2991.0279159273236;2992.072457538163;3019.8037127586717;3050.8474576271183;3070.52406876934;5181.196914478252;5203.089459344609;5203.297554830102;5325.494078062583;5352.732363381835;5245.632805703603;5272.894542109165;5275.815346462875;5291.656042357244;5331;4725.834595789148;4793.233082706767;4806.975965120169;4813.3983252093485;4998.750062496879;4884.169691152495;4919.11455937931;4924.950750492485;4927.950720492785;4984.77568509418;4695.929561056587;4725.31482934976;4738.502457241974;4745.905081898377;4827.493113223096;4758.857234282977;4770.594499467549;4783.665143439961;4830.347903033081;4837.274408838667;4733.077049975256;4738.6209103272;4739.19433696269;4779.163646361908;4815.0610630926985;5182.326297581328;5210.192420174879;5214.843554693327;5289.259503669489;5295.708736019517;5561.054620714488;5579.832605021856;5584.106542953149;5586.329640443173;5615.971920140373;5595.608307418483;5617.915731263994;5626.043572592669;5629.4652008059575;5632;5055.191169412877;5218.269442278084;5239.633225674204;5253.080710875582;5283.815066472655;5766.1062535306255;5771.220885180531;5775.191473193756;5776.1624564437925;5826.563007774434;5534.4742249486235;5544.805931792368;5550.222968784374;5551.333839939233;5555.555555555546;5389.245505629215;5523.751431185526;5561.221428999943;5569.192467092249;5596.468335508121;5500.037493438712;5539.307586551681;5547.084731019418;5551.72241387929;5612.326520817446;5483.287172667528;5496.697681627469;5509.5041446270025;5530.58969962665;5564.554835613141;4266.210751011073;4299.505556861001;4329.9134017319475;4347.847825326162;4350.32569951658;3859.7877116758846;3873.1091848874917;3909.3158697227873;3911.4915061041884;3933.6066393360434;5297.29836792904;5300.178472336794;5301.045811753845;5303.469653034743;5369.4362091980565;5564.582656300713;5587.1339942309005;5597.8600534986135;5637.069883469264;5663.122216056436;5398.2982212312145;5399.487048730443;5399.514043736082;5441.102218134043;5441.5102640762525;4944.75276236194;4947.925781113287;4947.950520494749;4959.752012399438;5012.248162775612;5658.066419040812;5758.913616295759;5780.930527852361;5828.88342233153;5853.1220316952795;5653.604247702621;5659.434056594308;5662.943370566241;5716.742746576498;5718.51392631631;5838.503727183237;5839.0949402842625;5839.35767065614;5844.707764611668;5847.327557330961;5402.945970540244;5567.888642227052;5570.61005729595;5578.748956296895;5595.468430499096;5676.602637815313;5703.173039909107;5704.771809127588;5756.740946657326;5786.016377215799;5587.44125587438;5596.720163991866;5604.243427137448;5604.775808967759;5605.103183490622;5298.337707786527;5514.558835293247;5545.390007099135;5560.916586251128;5596.888062238651;5494.642848214853;5497.532709719559;5503.862403439946;5558.638688485235;5567.777288908398;5579.107342825128;5594.888102238014;5597.552195824405;5609;5609.4390560943575;5323.0950738373795;5340.599455040965;5363.812266570651;5465.125579907355;5553 06:13:22 INFO - PROCESS | 29714 | |1;ext.html;576.2623841482904;583.9386864379237;591.0720169334147;604.8941435248831;622.4118208293163;42931.57068429315;44801.99999999992;44846.775766121165;44853.999999999956;47232.29151562721;44838.32742508865;45329.32006019913;45410.31884521735;45446.545534544646;45459.54540454594;8847.424917380382;9000.684976025841;9012.864807027867;9038.864417033717;9041.95479022604;8830.426022308562;8898.110188981114;8913.910860891405;8919.95540022299;8922.866157007618;8964.551772411385;8995.550222488882;9002.909970900273;9008.0541543138;9010.729678109634;8912.643494260254;8947.821043579157;8955.552222388887;8967.596458159398;9019.188273055457;8877.778055548599;8890.244329232022;8932.285417166611;8951.149640784115;8958.596863141174;42336.36495452571;42378;42800.3579946301;42813.571864281585;42846;3379.1721028347965;3467.1852114753015;3484.1463841358777;3819.3888977763704;3900.0054985978395;32165.1958701032;32274.677253227637;32312;32588;34289.314213715836;4136.565660605623;4143.97928010361;4188.958110418887;4195.181939521794;4214.894627634303;320452;320504;322523.3873830639;322777;323988;56664.71667641718;56864;56980.715096424254;56996;57010.144847827316;52974;59057.40942590605;60352;60384.69807650934;65352;16629.584260393585;16845.663086738197;16851.91574042122;16853.831461685473;16858.915705421394;11317.094632429385;13813.24027178515;14038.36827342772;14041.438342466186;14056.648583785487;16018.519444416686;16116.677666446605;16340.509784706477;16384.033915929926;16469.58826029359;6538.509611779041;6653.367930046637;6657.400833924873;6703.687227906462;6773.695183716744;947.7820101376584;995.348047029197;1080.7892460970036;1081.378207530673;1133.110508251019;31173.597188126136;31405.685943140277;31823.840880795447;32249.51625725616;32572;1078.9892101079047;1087.3095584303867;1092.1208427216168;1110.0730889707186;1120.0983208517223;16082.839171608368;16606.83393166077;16619.750703739453;16657.416990405276;16778.916105419394;520570;520648;521474;523753;524325;58112.41887581155;58116;58181.4181858176;58192;58217.12674309889;1309.8231738715342;1339.8124262603244;1351.959441216765;1356.905016648825;1364.4814970311418;29147;30786.53820192654;30916.690833091383;31419.84290078535;31499;50336;50736.49263507318;50779.23831142462;50797.49202507928;50844.74577627088;434601;437128;438975;439489;440672;32460.675393245765;32561.837190813894;40754.38868417036;40899.591004089576;41128;47454.288185677935;47548.524514755794;47942.76028619835;48109.27836082392;48306.758466207444;39181.60818391779;39748.00629984274;40140.197196055335;41875.37186942259;42109.78945105255;40781.59218407897;40807.59192408038;41188.38217426801;42236.155276894904;42425.78787106045;39263.41104883372;39540.80229598834;40229.597704022584;40454.1909161821;40481.797591011855;34354.82822585871;36572.63427365692;36580;37063.629363706015;37368.62631373652;27104.45791084128;27104.457910842066;27276;27300.86349568319;27434.314142146606 06:13:22 INFO - PROCESS | 29714 | |2;jquery.html;367.0768018433638;377.6223776223776;384.2066133434456;384.77875221747496;398.98603548875775;17605.119744012813;19370.90314548427;19690.90154549229;20381;20801.27195548156;19859.10634021469;20003.89998050008;20331.186752529917;20476.488087797814;20786;5093.541581257686;5560.916586251209;5715.657060576379;5725.828225153231;5776.104703770901;4276.481848943627;5815.38938411467;5961.821145365624;6275.529335299848;6295.622262664232;6161.445469907708;6324.177856878622;6357.11000459936;6359;6368.29948705642;6577.572457790252;6596.340365963413;6624.933750662528;6625.238097618787;6627.536072474929;5381.0583147948955;5469.398366179717;5521.309836270466;5794.565407594405;5802.854928626776;23539.056798072426;23674.881625591934;23943.88028059866;24031.87984060086;24207;2353.505763789606;2374.1334412939327;2430.8419952703193;2506.0602274147195;2520.4329025969196;13787.586372408843;14230.075045122034;14284.642883927881;14815.70368592622;15321.693566128726;1884.9905750471296;1944.931927382549;1953.2479995201807;1975.3777560068531;2052.8255098316513;73727.63136184338;75914.62042689807;76408.99999999945;82185.58907205485;87075.9862615801;10338.793224135476;10430;10563.894361056446;10580.25938184335;10679.65047689507;14233.43066277358;14248.145111293356;14306.85693143076;14335.713285734228;14337.283135843167;7795.610219489003;7843.56860372685;8026.879596806052;8361;8439.367047471464;8029.75166953254;8063.556504392314;8166.632501537326;8300.252977232078;8354.248117669438;4208.642265407413;4311.956880431218;4340.587644173798;4371.103923695635;5025.924611130836;1816.7184086466618;1851.1947302923272;1858.3402891973155;1862.3574866670976;1874.5313671582105;901.1754244866005;961.3030552849128;968.1141755293968;978.5156347607838;1046.895310468947;18421.355252566365;19888.90055549713;19986.70019949702;20021;20084.89957550203;939.6899023322287;962.6871266838166;967.8644989701447;1008.8688470498788;1014.974625634365;10553.47232638365;10984.560617575367;11024.669259922215;11030.613928512463;11048.723781905517;415935;418552.7940683907;429059;429510;432710;53582;78496.21503785004;89510;90999;91628.54185729162;972.1056627902346;975.8194733974237;980.4411485453223;990.7523119220195;1029.984550231747;17137.828621713623;17731.64536709233;17944.427517519827;18188;18193.818061819213;43127;43265.24082350876;44161;44430.3335449975;44765.689435405526;57499;57842.7107864458;58886;59426.405735942084;59824.40175598362;8175.468594541336;8337;8554.615042322986;8771.736847894574;8882.60028298741;12910.612681619567;13206.27365494907;13240.602781916557;13476.5283215087;13589.116707413987;10992.670219893416;11119;11311.830322545333;11578.710532236424;11898;11352.602658906899;11423.485943132746;11544.538218471167;11631.59289424866;11696.298222106701;5380.946190538201;11352.716182095513;11438.94280528592;11547.769044619228;11894.365563893274;8069;8218.671253149807;8381.413301068867;8445.071042185478;8549.418357603863;10292.845607316047;10824.4046577439;11026.779464410827;11459.885401146215;11636 06:13:22 INFO - PROCESS | 29714 | |3;mootools.html;1348.5010546097944;1478.2017710436362;1508.0047168868546;1639.8524132828043;1767.7525146479495;8355.874661880069;8747.12528747125;8777.03452620212;9029.367944243906;9119;8859.955700221506;8954.19412252897;8964.775880602989;8968.865467017984;8988;2084.437201955471;2287.49675071484;2382.28531440568;2435.0868424340874;2440.2191298784396;2348.495073559184;2372.5610762008996;2386.7135943686694;2391.880405979694;2411.1801987324307;2328.2549584133085;2351.318117745852;2372.1578839511985;2376.702912135983;2377.3581133094053;2226.3543572363997;2317.6755254264417;2326.09282379872;2333.556624241389;2335.988320058397;2353.870537120458;2384.2966324934187;2386.85678859269;2390.6653068570413;2393.6050551658955;8827.602757875911;8867.955660221722;8908.287337013024;8909.376343655947;8912.420692655021;5236.973815130938;5340.866478338034;5349.572034237291;5352.116900711417;5359.1425371940695;3249.886253981123;3322.700956913865;3446.172918499567;3493.423585108454;3497.475378693191;1142.5772464188303;1176.4882276209876;1206.4751832952693;1228.8033914573714;1238.7584421037902;11941.164118511708;12195.45120469572;12201.877981220163;12202.511899524008;12244.081693872995;4424.358468022118;4530.411046563926;4682.906341873144;4704.5765881070865;4704.647151463585;10438.425886576159;10452;10452.268341216042;10467.528961196764;10478;5260.210968354778;5293.788248470018;5296.126139186991;5304.893902121936;5352.785888564492;4290.635295999875;4635.235186194308;4713.905721885543;4841.467438581753;4874.2201247800185;3979.1047014421524;4087.713860029829;4148.419221309019;4152;4183.184279065614;1296.4166125243678;1323.2854258700386;1342.2148043394723;1347.9528216512374;1357.056845492393;793.305857374797;841.8947631546057;861.0743450790426;870.7387783665002;950.7813202963357;5737.85655358611;5752.856178595569;5818.44724751148;5884.264466941632;6183.258009038944;903.1149473515991;914.8216097860986;953.6328513522344;957.4016239850093;965.2471072563412;3770.4155855842387;3854.209886973164;3918.8432462701744;3959.1883663848844;4092.7953602319767;10923.180761442765;11189.44052797357;11278.323300601991;11317.434128293553;11321.490532926038;11087.33475991443;11187.272827266203;11227.775444491064;11322.094232461382;11325.773484530264;8036.638351274207;8330.916690833135;8385.245327920517;8390.622421991025;8528.829423411496;5765.164051212634;5925.156444306833;5957.314908785545;6010.579259451796;6016.759329626941;10334.224933130195;10396.012378824;10447.68656940293;10457.372557646566;10515.211359147941;10001;10656.360618362924;10663.626773062906;10664.893351066701;10699.14406847466;6732.596044237362;7577.5453472791805;7774.455788094779;7859.646315915683;7972.920270797218;8376.371772117238;8495.702650407206;8516.361272904682;8531.274841638531;8533.530655813742;7101.4673899458785;7306.269373062863;7361.190269070505;7378.520396174232;7453.478256521991;7132.964335178291;7170.103737032871;7245.094363204599;7274.672639731119;7290.307420795016;6674.566153200027;6681.46548276127;6712.9664351679885;6731.922892337203;6740.831479213059;4832.057748739103;4870.391201099863;4881.609471242221;4891.853244402673;4977;4884.145274577006;4925.926111108408;4934.753262336797;4995.475475075064;5110.4123025852505 06:13:22 INFO - PROCESS | 29714 | |4;prototype.html;320.20269528873115;333.2119537294299;334.2679531825301;336.4952571143285;337.90707555422256;5181.948180518194;5264.263003179558;5277.70972596507;5293.15309550472;5301.7879284828605;5242.449542798008;5252.52727254547;5263.894722105556;5271.789128434868;5329.827437963651;4132.462779838616;4156.729812562174;4164.97917510412;4173.227952828721;4186.832526698943;4069.837206511736;4169.499660040799;4178.373244013407;4180.393842892779;4193.496780386358;4130.277201489742;4133.483314585676;4133.503979522461;4138.937915931248;4169.249535083683;4125.525564560084;4160.167966406716;4163.625273725349;4175.895602609929;4183.811728472226;3504.316658251642;3619.113317237294;3625.111847597329;3631.364511210528;3725.6460636239512;5074.746262686888;5075.796968121271;5079.492050794928;5079.7300674831295;5099.515546023122;4692.55420735033;4709.929351059737;4715.7877895494785;4738.4550776660435;4757.500462451462;5330.600204984642;5389.353277606673;5402.567794576425;5411.675299482044;5449.618526703132;3931.174453364797;3949.8420063197723;3962.0094976255937;3963.2271707017144;3966.246413181515;5629.536320556685;5652.74562644682;5693.857653558653;5699.601027928046;5714.599978001542;3975.3043217436834;4001.799910004488;4063.6139566741113;4073.877783666495;4083.673306135502;4072.775997320176;4095.2833254180996;4111.054457474797;4115.855945041969;4131.235721391552;4643.86068417948;4647.535246475325;4669.626429885601;4669.719816811003;4717.669763116549;5214.634975551675;5463.2078348639225;5481.424450432727;5503.284573005483;5555.916661250085;1348.7976803479557;1381.7650999330137;1384.4946594492937;1400.7478653842406;1401.3763875075697;941.7975135345933;963.556763888605;979.3351302785294;979.985300220483;987.9012098790064;5214.921776173361;5223.727678459883;5228.55557277628;5232.215167724796;5239.480550640348;5475.425080366584;5490.752916118704;5492.862678433071;5504.146857237135;5514.931900537298;5071.46749591295;5200;5242.475752424803;5242.868928276824;5331.653442526223;2924.5613158026467;2963.9703602964128;2965.3772707731187;2969.8120751699494;2973.988843793121;5741.598088133874;5757.568182386254;5761.423857614289;5772.6536407815665;5791.362950075489;5511.944880551143;5652.18043383707;5728.398518155534;5744.425557444222;5770.740316685759;5776.768929242868;5798.768049277982;5812.6221795584;5815.185873977646;5856.385079566584;5423.566114710892;5622.915656265078;5628.324601047901;5648.4633959773755;5665.235193248858;5540.473655002768;5604.971975140098;5617.719114044363;5624.634398764068;5624.85937851557;5834.15404766315;5851.249912541099;5868.004878341384;5868.149118377897;5873.9412605873395;3858.9035274118373;4070.694697897729;4087.9167020738932;4097.610726981051;4102.753834769924;5291.391489978701;5539.390667026704;5619.719014049199;5646.632968857011;5663.5469162467725;5330.733463326741;5432.918506222489;5472.72636368188;5482.23248745184;5489.58828087903;5428.45715428454;5446.128619420873;5475.2334673145;5492.286002819608;5505.752241149078;5226.216067589892;5359.973200133974;5405.675659460445;5427.755750991294;5434.619576629598;5487.984722826131;5489.313835770528;5489.972550137383;5491.945080549143;5494.708743445367;5382.757775900172;5402.837914862561;5402.972985135049;5408.945910540844;5412.242286080031 06:13:22 INFO - PROCESS | 29714 | |5;yui.html;741.9072615923009;741.97774066778;753.9057617797775;768.0936494935977;783.3928705253431;14217.786733198998;14764.630884227887;14780.187089710062;14780.334884930176;14826.406943722264;15892.52322430326;15983.200839958014;16028;16034.919825400886;16050.27773750181;660.1022609251414;782.9882551761714;802.8394321135767;805.3798575097171;805.5649949027518;673.6631684157921;684.7089986755634;684.7979845945433;780.5745868501651;803.493798906688;825.5748289630845;837.4305472278847;838.4005436113177;839.2279103225047;839.3243439031577;833.829065041665;834.2491757418311;834.4784509681449;839.2949922065494;839.5340585974782;500.31207090250905;511.94112677042244;515.196293781698;614.8432149801816;615.062030403638;13392.464301427932;13996.72006559863;14024.929875350557;14471.348789304506;14491.275436228147;14109.858901410957;14536.854631453656;14835.851641483556;14900.180490073042;14965;11855.46650400734;11995.64013079609;12157.635270941886;12236.755264894653;12301.569445069379;3722.7394082414244;3798.088458769875;3813.523309586302;3840.116773142165;3847.384418493056;78816.60591697063;78890.6055469719;80017;80466.59766701187;81638.59180704117;11185.888141118647;11271.605493807678;11288.94355528217;11410.771784564262;11578.305301681927;18711.345102921332;18736.344227951955;18761.812381876007;18805.059747012594;19710.21159153618;8111.3916456266015;8113.432059755878;8121.431499795076;8378.706745263886;8382.329413646894;4652.278896771006;4680.3447517347595;4696.084263568571;4925.556699897026;5039.69761814285;3351.5475410819226;3446.4141096013736;3459.3568055174096;3465.6361082086523;3465.8960231193105;582.4408567774983;590.4420322794917;594.5124997502094;599.5413508665874;599.6462087368474;694.7464175575878;697.417656257031;704.7920863345325;715.7673756029311;720;8603.956980215058;8610.78473038179;8656.26421754158;8770.561471926378;8894.332925030649;691.9654017299115;693.1301216972668;712.6686090967725;721.3255606008399;721.3940290156294;4017.8995525112105;4287.421198138274;4385.6710746694125;4480.686351955332;4548.226801443762;112914;118587;118715;119052;123191.45638446113;94570.52714736383;98656;102565.48717256366;103927;105653.62368832843;91488;92970.53514732518;93071.53464232635;94603;94952.52523737337;8417.200365965224;8446.197611226924;8550.486970781772;8618.181272779077;8638.870416943626;42421.575784241766;42647.786761065996;44169.33745993749;55304.72347638397;55586.16620750611;68321;68392.6580367095;69078.65460672665;71196.64401677958;75237;11744.647660570197;12013.939930300292;12284.938575307066;12545.31000794965;12596.811047834106;13928.721425571635;14180.716385672435;14183.574492765234;14330.49843255481;14453.205073721047;12383.75232495363;12840.229586224856;13133.34333283351;13427.462901483832;14024.859751402355;12673.619791406272;13090.738185236432;13095.672608184872;13103.868961310645;13174.670633233862;13195.60413187606;13255.403506842407;13323.267220302976;13384.130031547918;13559.86440135586;9564.426134431957;9709.077637624414;9801.411915285105;9857.95071024669;10141.29010969225;9562.235021198427;10686.358818470917;10737.838932415863;10820.296680715728;10957.178211634318 06:13:22 INFO - PROCESS | 29714 | __end_tp_report 06:13:22 INFO - PROCESS | 29714 | __start_cc_report 06:13:22 INFO - PROCESS | 29714 | _x_x_mozilla_cycle_collect,1002 06:13:22 INFO - PROCESS | 29714 | __end_cc_report 06:13:22 INFO - PROCESS | 29714 | __startTimestamp1472649202879__endTimestamp 06:13:22 INFO - PROCESS | 29714 | 06:13:22 INFO - PROCESS | 29714 | ------- Summary: start ------- 06:13:22 INFO - PROCESS | 29714 | Number of tests: 6 06:13:22 INFO - PROCESS | 29714 | 06:13:22 INFO - PROCESS | 29714 | [#0] dojo.html Cycles:165 Average:5240.08 Median:5483.29 stddev:588.00 (10.7%) stddev-sans-first:562.71 06:13:22 INFO - PROCESS | 29714 | Values: 2991.0 2992.1 3019.8 3050.8 3070.5 5181.2 5203.1 5203.3 5325.5 5352.7 5245.6 5272.9 5275.8 5291.7 5331.0 4725.8 4793.2 4807.0 4813.4 4998.8 4884.2 4919.1 4925.0 4928.0 4984.8 4695.9 4725.3 4738.5 4745.9 4827.5 4758.9 4770.6 4783.7 4830.3 4837.3 4733.1 4738.6 4739.2 4779.2 4815.1 5182.3 5210.2 5214.8 5289.3 5295.7 5561.1 5579.8 5584.1 5586.3 5616.0 5595.6 5617.9 5626.0 5629.5 5632.0 5055.2 5218.3 5239.6 5253.1 5283.8 5766.1 5771.2 5775.2 5776.2 5826.6 5534.5 5544.8 5550.2 5551.3 5555.6 5389.2 5523.8 5561.2 5569.2 5596.5 5500.0 5539.3 5547.1 5551.7 5612.3 5483.3 5496.7 5509.5 5530.6 5564.6 4266.2 4299.5 4329.9 4347.8 4350.3 3859.8 3873.1 3909.3 3911.5 3933.6 5297.3 5300.2 5301.0 5303.5 5369.4 5564.6 5587.1 5597.9 5637.1 5663.1 5398.3 5399.5 5399.5 5441.1 5441.5 4944.8 4947.9 4948.0 4959.8 5012.2 5658.1 5758.9 5780.9 5828.9 5853.1 5653.6 5659.4 5662.9 5716.7 5718.5 5838.5 5839.1 5839.4 5844.7 5847.3 5402.9 5567.9 5570.6 5578.7 5595.5 5676.6 5703.2 5704.8 5756.7 5786.0 5587.4 5596.7 5604.2 5604.8 5605.1 5298.3 5514.6 5545.4 5560.9 5596.9 5494.6 5497.5 5503.9 5558.6 5567.8 5579.1 5594.9 5597.6 5609.0 5609.4 5323.1 5340.6 5363.8 5465.1 5553.0 06:13:22 INFO - PROCESS | 29714 | 06:13:22 INFO - PROCESS | 29714 | [#1] ext.html Cycles:180 Average:59263.63 Median:23225.52 stddev:115291.00 (496.4%) stddev-sans-first:115530.22 06:13:22 INFO - PROCESS | 29714 | Values: 576.3 583.9 591.1 604.9 622.4 42931.6 44802.0 44846.8 44854.0 47232.3 44838.3 45329.3 45410.3 45446.5 45459.5 8847.4 9000.7 9012.9 9038.9 9042.0 8830.4 8898.1 8913.9 8920.0 8922.9 8964.6 8995.6 9002.9 9008.1 9010.7 8912.6 8947.8 8955.6 8967.6 9019.2 8877.8 8890.2 8932.3 8951.1 8958.6 42336.4 42378.0 42800.4 42813.6 42846.0 3379.2 3467.2 3484.1 3819.4 3900.0 32165.2 32274.7 32312.0 32588.0 34289.3 4136.6 4144.0 4189.0 4195.2 4214.9 320452.0 320504.0 322523.4 322777.0 323988.0 56664.7 56864.0 56980.7 56996.0 57010.1 52974.0 59057.4 60352.0 60384.7 65352.0 16629.6 16845.7 16851.9 16853.8 16858.9 11317.1 13813.2 14038.4 14041.4 14056.6 16018.5 16116.7 16340.5 16384.0 16469.6 6538.5 6653.4 6657.4 6703.7 6773.7 947.8 995.3 1080.8 1081.4 1133.1 31173.6 31405.7 31823.8 32249.5 32572.0 1079.0 1087.3 1092.1 1110.1 1120.1 16082.8 16606.8 16619.8 16657.4 16778.9 520570.0 520648.0 521474.0 523753.0 524325.0 58112.4 58116.0 58181.4 58192.0 58217.1 1309.8 1339.8 1352.0 1356.9 1364.5 29147.0 30786.5 30916.7 31419.8 31499.0 50336.0 50736.5 50779.2 50797.5 50844.7 434601.0 437128.0 438975.0 439489.0 440672.0 32460.7 32561.8 40754.4 40899.6 41128.0 47454.3 47548.5 47942.8 48109.3 48306.8 39181.6 39748.0 40140.2 41875.4 42109.8 40781.6 40807.6 41188.4 42236.2 42425.8 39263.4 39540.8 40229.6 40454.2 40481.8 34354.8 36572.6 36580.0 37063.6 37368.6 27104.5 27104.5 27276.0 27300.9 27434.3 06:13:22 INFO - PROCESS | 29714 | 06:13:22 INFO - PROCESS | 29714 | [#2] jquery.html Cycles:180 Average:27048.72 Median:384.49 stddev:70262.73 (18274.1%) stddev-sans-first:70431.28 06:13:22 INFO - PROCESS | 29714 | Values: 367.1 377.6 384.2 384.8 399.0 17605.1 19370.9 19690.9 20381.0 20801.3 19859.1 20003.9 20331.2 20476.5 20786.0 5093.5 5560.9 5715.7 5725.8 5776.1 4276.5 5815.4 5961.8 6275.5 6295.6 6161.4 6324.2 6357.1 6359.0 6368.3 6577.6 6596.3 6624.9 6625.2 6627.5 5381.1 5469.4 5521.3 5794.6 5802.9 23539.1 23674.9 23943.9 24031.9 24207.0 2353.5 2374.1 2430.8 2506.1 2520.4 13787.6 14230.1 14284.6 14815.7 15321.7 1885.0 1944.9 1953.2 1975.4 2052.8 73727.6 75914.6 76409.0 82185.6 87076.0 10338.8 10430.0 10563.9 10580.3 10679.7 14233.4 14248.1 14306.9 14335.7 14337.3 7795.6 7843.6 8026.9 8361.0 8439.4 8029.8 8063.6 8166.6 8300.3 8354.2 4208.6 4312.0 4340.6 4371.1 5025.9 1816.7 1851.2 1858.3 1862.4 1874.5 901.2 961.3 968.1 978.5 1046.9 18421.4 19888.9 19986.7 20021.0 20084.9 939.7 962.7 967.9 1008.9 1015.0 10553.5 10984.6 11024.7 11030.6 11048.7 415935.0 418552.8 429059.0 429510.0 432710.0 53582.0 78496.2 89510.0 90999.0 91628.5 972.1 975.8 980.4 990.8 1030.0 17137.8 17731.6 17944.4 18188.0 18193.8 43127.0 43265.2 44161.0 44430.3 44765.7 57499.0 57842.7 58886.0 59426.4 59824.4 8175.5 8337.0 8554.6 8771.7 8882.6 12910.6 13206.3 13240.6 13476.5 13589.1 10992.7 11119.0 11311.8 11578.7 11898.0 11352.6 11423.5 11544.5 11631.6 11696.3 5380.9 11352.7 11438.9 11547.8 11894.4 8069.0 8218.7 8381.4 8445.1 8549.4 10292.8 10824.4 11026.8 11459.9 11636.0 06:13:22 INFO - PROCESS | 29714 | 06:13:22 INFO - PROCESS | 29714 | [#3] mootools.html Cycles:180 Average:5804.70 Median:4704.61 stddev:3339.56 (71.0%) stddev-sans-first:3332.14 06:13:22 INFO - PROCESS | 29714 | Values: 1348.5 1478.2 1508.0 1639.9 1767.8 8355.9 8747.1 8777.0 9029.4 9119.0 8860.0 8954.2 8964.8 8968.9 8988.0 2084.4 2287.5 2382.3 2435.1 2440.2 2348.5 2372.6 2386.7 2391.9 2411.2 2328.3 2351.3 2372.2 2376.7 2377.4 2226.4 2317.7 2326.1 2333.6 2336.0 2353.9 2384.3 2386.9 2390.7 2393.6 8827.6 8868.0 8908.3 8909.4 8912.4 5237.0 5340.9 5349.6 5352.1 5359.1 3249.9 3322.7 3446.2 3493.4 3497.5 1142.6 1176.5 1206.5 1228.8 1238.8 11941.2 12195.5 12201.9 12202.5 12244.1 4424.4 4530.4 4682.9 4704.6 4704.6 10438.4 10452.0 10452.3 10467.5 10478.0 5260.2 5293.8 5296.1 5304.9 5352.8 4290.6 4635.2 4713.9 4841.5 4874.2 3979.1 4087.7 4148.4 4152.0 4183.2 1296.4 1323.3 1342.2 1348.0 1357.1 793.3 841.9 861.1 870.7 950.8 5737.9 5752.9 5818.4 5884.3 6183.3 903.1 914.8 953.6 957.4 965.2 3770.4 3854.2 3918.8 3959.2 4092.8 10923.2 11189.4 11278.3 11317.4 11321.5 11087.3 11187.3 11227.8 11322.1 11325.8 8036.6 8330.9 8385.2 8390.6 8528.8 5765.2 5925.2 5957.3 6010.6 6016.8 10334.2 10396.0 10447.7 10457.4 10515.2 10001.0 10656.4 10663.6 10664.9 10699.1 6732.6 7577.5 7774.5 7859.6 7972.9 8376.4 8495.7 8516.4 8531.3 8533.5 7101.5 7306.3 7361.2 7378.5 7453.5 7133.0 7170.1 7245.1 7274.7 7290.3 6674.6 6681.5 6713.0 6731.9 6740.8 4832.1 4870.4 4881.6 4891.9 4977.0 4884.1 4925.9 4934.8 4995.5 5110.4 06:13:22 INFO - PROCESS | 29714 | 06:13:22 INFO - PROCESS | 29714 | [#4] prototype.html Cycles:180 Average:4626.35 Median:5268.03 stddev:1344.76 (25.5%) stddev-sans-first:1309.12 06:13:22 INFO - PROCESS | 29714 | Values: 320.2 333.2 334.3 336.5 337.9 5181.9 5264.3 5277.7 5293.2 5301.8 5242.4 5252.5 5263.9 5271.8 5329.8 4132.5 4156.7 4165.0 4173.2 4186.8 4069.8 4169.5 4178.4 4180.4 4193.5 4130.3 4133.5 4133.5 4138.9 4169.2 4125.5 4160.2 4163.6 4175.9 4183.8 3504.3 3619.1 3625.1 3631.4 3725.6 5074.7 5075.8 5079.5 5079.7 5099.5 4692.6 4709.9 4715.8 4738.5 4757.5 5330.6 5389.4 5402.6 5411.7 5449.6 3931.2 3949.8 3962.0 3963.2 3966.2 5629.5 5652.7 5693.9 5699.6 5714.6 3975.3 4001.8 4063.6 4073.9 4083.7 4072.8 4095.3 4111.1 4115.9 4131.2 4643.9 4647.5 4669.6 4669.7 4717.7 5214.6 5463.2 5481.4 5503.3 5555.9 1348.8 1381.8 1384.5 1400.7 1401.4 941.8 963.6 979.3 980.0 987.9 5214.9 5223.7 5228.6 5232.2 5239.5 5475.4 5490.8 5492.9 5504.1 5514.9 5071.5 5200.0 5242.5 5242.9 5331.7 2924.6 2964.0 2965.4 2969.8 2974.0 5741.6 5757.6 5761.4 5772.7 5791.4 5511.9 5652.2 5728.4 5744.4 5770.7 5776.8 5798.8 5812.6 5815.2 5856.4 5423.6 5622.9 5628.3 5648.5 5665.2 5540.5 5605.0 5617.7 5624.6 5624.9 5834.2 5851.2 5868.0 5868.1 5873.9 3858.9 4070.7 4087.9 4097.6 4102.8 5291.4 5539.4 5619.7 5646.6 5663.5 5330.7 5432.9 5472.7 5482.2 5489.6 5428.5 5446.1 5475.2 5492.3 5505.8 5226.2 5360.0 5405.7 5427.8 5434.6 5488.0 5489.3 5490.0 5491.9 5494.7 5382.8 5402.8 5403.0 5408.9 5412.2 06:13:22 INFO - PROCESS | 29714 | 06:13:22 INFO - PROCESS | 29714 | [#5] yui.html Cycles:180 Average:20775.72 Median:4600.25 stddev:30849.76 (670.6%) stddev-sans-first:30899.63 06:13:22 INFO - PROCESS | 29714 | Values: 741.9 742.0 753.9 768.1 783.4 14217.8 14764.6 14780.2 14780.3 14826.4 15892.5 15983.2 16028.0 16034.9 16050.3 660.1 783.0 802.8 805.4 805.6 673.7 684.7 684.8 780.6 803.5 825.6 837.4 838.4 839.2 839.3 833.8 834.2 834.5 839.3 839.5 500.3 511.9 515.2 614.8 615.1 13392.5 13996.7 14024.9 14471.3 14491.3 14109.9 14536.9 14835.9 14900.2 14965.0 11855.5 11995.6 12157.6 12236.8 12301.6 3722.7 3798.1 3813.5 3840.1 3847.4 78816.6 78890.6 80017.0 80466.6 81638.6 11185.9 11271.6 11288.9 11410.8 11578.3 18711.3 18736.3 18761.8 18805.1 19710.2 8111.4 8113.4 8121.4 8378.7 8382.3 4652.3 4680.3 4696.1 4925.6 5039.7 3351.5 3446.4 3459.4 3465.6 3465.9 582.4 590.4 594.5 599.5 599.6 694.7 697.4 704.8 715.8 720.0 8604.0 8610.8 8656.3 8770.6 8894.3 692.0 693.1 712.7 721.3 721.4 4017.9 4287.4 4385.7 4480.7 4548.2 112914.0 118587.0 118715.0 119052.0 123191.5 94570.5 98656.0 102565.5 103927.0 105653.6 91488.0 92970.5 93071.5 94603.0 94952.5 8417.2 8446.2 8550.5 8618.2 8638.9 42421.6 42647.8 44169.3 55304.7 55586.2 68321.0 68392.7 69078.7 71196.6 75237.0 11744.6 12013.9 12284.9 12545.3 12596.8 13928.7 14180.7 14183.6 14330.5 14453.2 12383.8 12840.2 13133.3 13427.5 14024.9 12673.6 13090.7 13095.7 13103.9 13174.7 13195.6 13255.4 13323.3 13384.1 13559.9 9564.4 9709.1 9801.4 9858.0 10141.3 9562.2 10686.4 10737.8 10820.3 10957.2 06:13:22 INFO - PROCESS | 29714 | -------- Summary: end -------- 06:13:22 INFO - PROCESS | 29714 | 06:13:23 INFO - TEST-INFO | 29714: exit 0 06:13:23 INFO - TEST-OK | dromaeo_css | took 1115480ms 06:13:23 INFO - TEST-START | kraken 06:13:23 INFO - operating with platform_type : linux_ 06:13:23 INFO - Initialising browser for kraken test... 06:13:23 INFO - TEST-INFO | started process 30024 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZTaL8x/profile http://localhost:57236/getInfo.html) 06:13:27 INFO - PROCESS | 30024 | __metrics Screen width/height:1600/1200 06:13:27 INFO - PROCESS | 30024 | colorDepth:24 06:13:27 INFO - PROCESS | 30024 | Browser inner width/height: 1024/697 06:13:27 INFO - PROCESS | 30024 | __metrics 06:13:28 INFO - PROCESS | 30024 | 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" 06:13:28 INFO - PROCESS | 30024 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:13:28 INFO - PROCESS | 30024 | console.error: PushService: 06:13:28 INFO - PROCESS | 30024 | stateChangeProcessEnqueue: Error transitioning state 06:13:28 INFO - PROCESS | 30024 | UnknownError 06:13:29 INFO - TEST-INFO | 30024: exit 0 06:13:29 INFO - Browser initialized. 06:13:29 INFO - Running cycle 1/1 for kraken test... 06:13:29 INFO - TEST-INFO | started process 30105 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZTaL8x/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:13:41 INFO - PROCESS | 30105 | RSS: Main: 180248576 06:13:41 INFO - PROCESS | 30105 | 06:13:44 INFO - PROCESS | 30105 | Cycle 1(1): loaded http://localhost:57236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57236/tests/kraken/driver.html?testName=audio-beat-detection) 06:13:45 INFO - PROCESS | 30105 | RSS: Main: 238153728 06:13:45 INFO - PROCESS | 30105 | 06:13:47 INFO - PROCESS | 30105 | Cycle 1(1): loaded http://localhost:57236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57236/tests/kraken/driver.html?testName=audio-dft) 06:13:48 INFO - PROCESS | 30105 | RSS: Main: 224657408 06:13:48 INFO - PROCESS | 30105 | 06:13:51 INFO - PROCESS | 30105 | Cycle 1(1): loaded http://localhost:57236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57236/tests/kraken/driver.html?testName=audio-fft) 06:13:51 INFO - PROCESS | 30105 | RSS: Main: 301334528 06:13:51 INFO - PROCESS | 30105 | 06:13:54 INFO - PROCESS | 30105 | Cycle 1(1): loaded http://localhost:57236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57236/tests/kraken/driver.html?testName=audio-oscillator) 06:13:54 INFO - PROCESS | 30105 | RSS: Main: 212561920 06:13:54 INFO - PROCESS | 30105 | 06:13:56 INFO - PROCESS | 30105 | Cycle 1(1): loaded http://localhost:57236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:13:57 INFO - PROCESS | 30105 | RSS: Main: 213663744 06:13:57 INFO - PROCESS | 30105 | 06:14:00 INFO - PROCESS | 30105 | Cycle 1(1): loaded http://localhost:57236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57236/tests/kraken/driver.html?testName=imaging-darkroom) 06:14:01 INFO - PROCESS | 30105 | RSS: Main: 252235776 06:14:01 INFO - PROCESS | 30105 | 06:14:04 INFO - PROCESS | 30105 | Cycle 1(1): loaded http://localhost:57236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57236/tests/kraken/driver.html?testName=imaging-desaturate) 06:14:05 INFO - PROCESS | 30105 | RSS: Main: 251756544 06:14:05 INFO - PROCESS | 30105 | 06:14:07 INFO - PROCESS | 30105 | Cycle 1(1): loaded http://localhost:57236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57236/tests/kraken/driver.html?testName=json-parse-financial) 06:14:08 INFO - PROCESS | 30105 | RSS: Main: 251305984 06:14:08 INFO - PROCESS | 30105 | 06:14:09 INFO - PROCESS | 30105 | Cycle 1(1): loaded http://localhost:57236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:14:10 INFO - PROCESS | 30105 | RSS: Main: 214048768 06:14:10 INFO - PROCESS | 30105 | 06:14:12 INFO - PROCESS | 30105 | Cycle 1(1): loaded http://localhost:57236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57236/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:14:12 INFO - PROCESS | 30105 | RSS: Main: 219635712 06:14:12 INFO - PROCESS | 30105 | 06:14:15 INFO - PROCESS | 30105 | Cycle 1(1): loaded http://localhost:57236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:14:15 INFO - PROCESS | 30105 | RSS: Main: 222244864 06:14:15 INFO - PROCESS | 30105 | 06:14:18 INFO - PROCESS | 30105 | Cycle 1(1): loaded http://localhost:57236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:14:18 INFO - PROCESS | 30105 | RSS: Main: 223375360 06:14:18 INFO - PROCESS | 30105 | 06:14:21 INFO - PROCESS | 30105 | Cycle 1(1): loaded http://localhost:57236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:14:22 INFO - PROCESS | 30105 | RSS: Main: 221016064 06:14:22 INFO - PROCESS | 30105 | 06:14:23 INFO - PROCESS | 30105 | Cycle 1(1): loaded http://localhost:57236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57236/tests/kraken/driver.html?testName=ai-astar) 06:14:24 INFO - PROCESS | 30105 | RSS: Main: 272678912 06:14:24 INFO - PROCESS | 30105 | 06:14:24 INFO - PROCESS | 30105 | __start_tp_report 06:14:24 INFO - PROCESS | 30105 | _x_x_mozilla_page_load 06:14:24 INFO - PROCESS | 30105 | _x_x_mozilla_page_load_details 06:14:24 INFO - PROCESS | 30105 | |i|pagename|runs| 06:14:24 INFO - PROCESS | 30105 | |0;ai-astar;113;113;131;111;111;110;110;110;110;110 06:14:24 INFO - PROCESS | 30105 | |1;audio-beat-detection;150;119;153;180;118;156;146;124;173;120 06:14:24 INFO - PROCESS | 30105 | |2;audio-dft;161;161;162;162;161;163;163;162;160;161 06:14:24 INFO - PROCESS | 30105 | |3;audio-fft;75;75;76;177;76;77;76;76;167;75 06:14:24 INFO - PROCESS | 30105 | |4;audio-oscillator;82;82;144;81;81;81;147;82;81;146 06:14:24 INFO - PROCESS | 30105 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 06:14:24 INFO - PROCESS | 30105 | |6;imaging-darkroom;149;149;148;148;148;147;147;146;148;147 06:14:24 INFO - PROCESS | 30105 | |7;imaging-desaturate;94;96;95;95;96;95;95;94;95;95 06:14:24 INFO - PROCESS | 30105 | |8;json-parse-financial;51;50;52;53;52;55;54;52;53;52 06:14:24 INFO - PROCESS | 30105 | |9;json-stringify-tinderbox;62;62;61;61;62;61;62;63;62;62 06:14:24 INFO - PROCESS | 30105 | |10;stanford-crypto-aes;80;80;84;78;79;86;82;80;79;78 06:14:24 INFO - PROCESS | 30105 | |11;stanford-crypto-ccm;141;139;122;127;126;138;122;128;172;125 06:14:24 INFO - PROCESS | 30105 | |12;stanford-crypto-pbkdf2;163;161;161;161;161;161;158;159;165;161 06:14:24 INFO - PROCESS | 30105 | |13;stanford-crypto-sha256-iterative;65;63;65;67;64;65;64;65;66;63 06:14:24 INFO - PROCESS | 30105 | __end_tp_report 06:14:24 INFO - PROCESS | 30105 | __start_cc_report 06:14:24 INFO - PROCESS | 30105 | _x_x_mozilla_cycle_collect,1769 06:14:24 INFO - PROCESS | 30105 | __end_cc_report 06:14:24 INFO - PROCESS | 30105 | __startTimestamp1472649264122__endTimestamp 06:14:24 INFO - PROCESS | 30105 | 06:14:24 INFO - PROCESS | 30105 | ------- Summary: start ------- 06:14:24 INFO - PROCESS | 30105 | Number of tests: 14 06:14:24 INFO - PROCESS | 30105 | 06:14:24 INFO - PROCESS | 30105 | [#0] ai-astar Cycles:10 Average:112.90 Median:111.00 stddev:6.47 (5.8%) stddev-sans-first:6.86 06:14:24 INFO - PROCESS | 30105 | Values: 113.0 113.0 131.0 111.0 111.0 110.0 110.0 110.0 110.0 110.0 06:14:24 INFO - PROCESS | 30105 | 06:14:24 INFO - PROCESS | 30105 | [#1] audio-beat-detection Cycles:10 Average:143.90 Median:151.50 stddev:22.80 (15.1%) stddev-sans-first:24.08 06:14:24 INFO - PROCESS | 30105 | Values: 150.0 119.0 153.0 180.0 118.0 156.0 146.0 124.0 173.0 120.0 06:14:24 INFO - PROCESS | 30105 | 06:14:24 INFO - PROCESS | 30105 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 06:14:24 INFO - PROCESS | 30105 | Values: 161.0 161.0 162.0 162.0 161.0 163.0 163.0 162.0 160.0 161.0 06:14:24 INFO - PROCESS | 30105 | 06:14:24 INFO - PROCESS | 30105 | [#3] audio-fft Cycles:10 Average:95.00 Median:76.00 stddev:40.66 (53.5%) stddev-sans-first:42.47 06:14:24 INFO - PROCESS | 30105 | Values: 75.0 75.0 76.0 177.0 76.0 77.0 76.0 76.0 167.0 75.0 06:14:24 INFO - PROCESS | 30105 | 06:14:24 INFO - PROCESS | 30105 | [#4] audio-oscillator Cycles:10 Average:100.70 Median:81.00 stddev:31.04 (38.3%) stddev-sans-first:32.18 06:14:24 INFO - PROCESS | 30105 | Values: 82.0 82.0 144.0 81.0 81.0 81.0 147.0 82.0 81.0 146.0 06:14:24 INFO - PROCESS | 30105 | 06:14:24 INFO - PROCESS | 30105 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 06:14:24 INFO - PROCESS | 30105 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 06:14:24 INFO - PROCESS | 30105 | 06:14:24 INFO - PROCESS | 30105 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.95 (0.6%) stddev-sans-first:0.88 06:14:24 INFO - PROCESS | 30105 | Values: 149.0 149.0 148.0 148.0 148.0 147.0 147.0 146.0 148.0 147.0 06:14:24 INFO - PROCESS | 30105 | 06:14:24 INFO - PROCESS | 30105 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.60 06:14:24 INFO - PROCESS | 30105 | Values: 94.0 96.0 95.0 95.0 96.0 95.0 95.0 94.0 95.0 95.0 06:14:24 INFO - PROCESS | 30105 | 06:14:24 INFO - PROCESS | 30105 | [#8] json-parse-financial Cycles:10 Average:52.40 Median:52.50 stddev:1.43 (2.7%) stddev-sans-first:1.42 06:14:24 INFO - PROCESS | 30105 | Values: 51.0 50.0 52.0 53.0 52.0 55.0 54.0 52.0 53.0 52.0 06:14:24 INFO - PROCESS | 30105 | 06:14:24 INFO - PROCESS | 30105 | [#9] json-stringify-tinderbox Cycles:10 Average:61.80 Median:62.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 06:14:24 INFO - PROCESS | 30105 | Values: 62.0 62.0 61.0 61.0 62.0 61.0 62.0 63.0 62.0 62.0 06:14:24 INFO - PROCESS | 30105 | 06:14:24 INFO - PROCESS | 30105 | [#10] stanford-crypto-aes Cycles:10 Average:80.60 Median:80.00 stddev:2.63 (3.3%) stddev-sans-first:2.78 06:14:24 INFO - PROCESS | 30105 | Values: 80.0 80.0 84.0 78.0 79.0 86.0 82.0 80.0 79.0 78.0 06:14:24 INFO - PROCESS | 30105 | 06:14:24 INFO - PROCESS | 30105 | [#11] stanford-crypto-ccm Cycles:10 Average:134.00 Median:133.00 stddev:15.10 (11.4%) stddev-sans-first:15.80 06:14:24 INFO - PROCESS | 30105 | Values: 141.0 139.0 122.0 127.0 126.0 138.0 122.0 128.0 172.0 125.0 06:14:24 INFO - PROCESS | 30105 | 06:14:24 INFO - PROCESS | 30105 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.10 Median:161.00 stddev:1.91 (1.2%) stddev-sans-first:1.90 06:14:24 INFO - PROCESS | 30105 | Values: 163.0 161.0 161.0 161.0 161.0 161.0 158.0 159.0 165.0 161.0 06:14:24 INFO - PROCESS | 30105 | 06:14:24 INFO - PROCESS | 30105 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.70 Median:65.00 stddev:1.25 (1.9%) stddev-sans-first:1.32 06:14:24 INFO - PROCESS | 30105 | Values: 65.0 63.0 65.0 67.0 64.0 65.0 64.0 65.0 66.0 63.0 06:14:24 INFO - PROCESS | 30105 | -------- Summary: end -------- 06:14:24 INFO - PROCESS | 30105 | 06:14:25 INFO - TEST-INFO | 30105: exit 0 06:14:25 INFO - TEST-OK | kraken | took 61643ms 06:14:25 INFO - SUITE-END | took 1177s 06:14:25 INFO - Completed test suite (00:19:37) 06:14:25 INFO - javascript benchmark 06:14:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2991.0279159273236, 2992.072457538163, 3019.8037127586717, 3050.8474576271183, 3070.52406876934, 5181.196914478252, 5203.089459344609, 5203.297554830102, 5325.494078062583, 5352.732363381835, 5245.632805703603, 5272.894542109165, 5275.815346462875, 5291.656042357244, 5331.0, 4725.834595789148, 4793.233082706767, 4806.975965120169, 4813.3983252093485, 4998.750062496879, 4884.169691152495, 4919.11455937931, 4924.950750492485, 4927.950720492785, 4984.77568509418, 4695.929561056587, 4725.31482934976, 4738.502457241974, 4745.905081898377, 4827.493113223096, 4758.857234282977, 4770.594499467549, 4783.665143439961, 4830.347903033081, 4837.274408838667, 4733.077049975256, 4738.6209103272, 4739.19433696269, 4779.163646361908, 4815.0610630926985, 5182.326297581328, 5210.192420174879, 5214.843554693327, 5289.259503669489, 5295.708736019517, 5561.054620714488, 5579.832605021856, 5584.106542953149, 5586.329640443173, 5615.971920140373, 5595.608307418483, 5617.915731263994, 5626.043572592669, 5629.4652008059575, 5632.0, 5055.191169412877, 5218.269442278084, 5239.633225674204, 5253.080710875582, 5283.815066472655, 5766.1062535306255, 5771.220885180531, 5775.191473193756, 5776.1624564437925, 5826.563007774434, 5534.4742249486235, 5544.805931792368, 5550.222968784374, 5551.333839939233, 5555.555555555546, 5389.245505629215, 5523.751431185526, 5561.221428999943, 5569.192467092249, 5596.468335508121, 5500.037493438712, 5539.307586551681, 5547.084731019418, 5551.72241387929, 5612.326520817446, 5483.287172667528, 5496.697681627469, 5509.5041446270025, 5530.58969962665, 5564.554835613141, 4266.210751011073, 4299.505556861001, 4329.9134017319475, 4347.847825326162, 4350.32569951658, 3859.7877116758846, 3873.1091848874917, 3909.3158697227873, 3911.4915061041884, 3933.6066393360434, 5297.29836792904, 5300.178472336794, 5301.045811753845, 5303.469653034743, 5369.4362091980565, 5564.582656300713, 5587.1339942309005, 5597.8600534986135, 5637.069883469264, 5663.122216056436, 5398.2982212312145, 5399.487048730443, 5399.514043736082, 5441.102218134043, 5441.5102640762525, 4944.75276236194, 4947.925781113287, 4947.950520494749, 4959.752012399438, 5012.248162775612, 5658.066419040812, 5758.913616295759, 5780.930527852361, 5828.88342233153, 5853.1220316952795, 5653.604247702621, 5659.434056594308, 5662.943370566241, 5716.742746576498, 5718.51392631631, 5838.503727183237, 5839.0949402842625, 5839.35767065614, 5844.707764611668, 5847.327557330961, 5402.945970540244, 5567.888642227052, 5570.61005729595, 5578.748956296895, 5595.468430499096, 5676.602637815313, 5703.173039909107, 5704.771809127588, 5756.740946657326, 5786.016377215799, 5587.44125587438, 5596.720163991866, 5604.243427137448, 5604.775808967759, 5605.103183490622, 5298.337707786527, 5514.558835293247, 5545.390007099135, 5560.916586251128, 5596.888062238651, 5494.642848214853, 5497.532709719559, 5503.862403439946, 5558.638688485235, 5567.777288908398, 5579.107342825128, 5594.888102238014, 5597.552195824405, 5609.0, 5609.4390560943575, 5323.0950738373795, 5340.599455040965, 5363.812266570651, 5465.125579907355, 5553.0], "value": 5200.5161501288285, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.2623841482904, 583.9386864379237, 591.0720169334147, 604.8941435248831, 622.4118208293163, 42931.57068429315, 44801.99999999992, 44846.775766121165, 44853.999999999956, 47232.29151562721, 44838.32742508865, 45329.32006019913, 45410.31884521735, 45446.545534544646, 45459.54540454594, 8847.424917380382, 9000.684976025841, 9012.864807027867, 9038.864417033717, 9041.95479022604, 8830.426022308562, 8898.110188981114, 8913.910860891405, 8919.95540022299, 8922.866157007618, 8964.551772411385, 8995.550222488882, 9002.909970900273, 9008.0541543138, 9010.729678109634, 8912.643494260254, 8947.821043579157, 8955.552222388887, 8967.596458159398, 9019.188273055457, 8877.778055548599, 8890.244329232022, 8932.285417166611, 8951.149640784115, 8958.596863141174, 42336.36495452571, 42378.0, 42800.3579946301, 42813.571864281585, 42846.0, 3379.1721028347965, 3467.1852114753015, 3484.1463841358777, 3819.3888977763704, 3900.0054985978395, 32165.1958701032, 32274.677253227637, 32312.0, 32588.0, 34289.314213715836, 4136.565660605623, 4143.97928010361, 4188.958110418887, 4195.181939521794, 4214.894627634303, 320452.0, 320504.0, 322523.3873830639, 322777.0, 323988.0, 56664.71667641718, 56864.0, 56980.715096424254, 56996.0, 57010.144847827316, 52974.0, 59057.40942590605, 60352.0, 60384.69807650934, 65352.0, 16629.584260393585, 16845.663086738197, 16851.91574042122, 16853.831461685473, 16858.915705421394, 11317.094632429385, 13813.24027178515, 14038.36827342772, 14041.438342466186, 14056.648583785487, 16018.519444416686, 16116.677666446605, 16340.509784706477, 16384.033915929926, 16469.58826029359, 6538.509611779041, 6653.367930046637, 6657.400833924873, 6703.687227906462, 6773.695183716744, 947.7820101376584, 995.348047029197, 1080.7892460970036, 1081.378207530673, 1133.110508251019, 31173.597188126136, 31405.685943140277, 31823.840880795447, 32249.51625725616, 32572.0, 1078.9892101079047, 1087.3095584303867, 1092.1208427216168, 1110.0730889707186, 1120.0983208517223, 16082.839171608368, 16606.83393166077, 16619.750703739453, 16657.416990405276, 16778.916105419394, 520570.0, 520648.0, 521474.0, 523753.0, 524325.0, 58112.41887581155, 58116.0, 58181.4181858176, 58192.0, 58217.12674309889, 1309.8231738715342, 1339.8124262603244, 1351.959441216765, 1356.905016648825, 1364.4814970311418, 29147.0, 30786.53820192654, 30916.690833091383, 31419.84290078535, 31499.0, 50336.0, 50736.49263507318, 50779.23831142462, 50797.49202507928, 50844.74577627088, 434601.0, 437128.0, 438975.0, 439489.0, 440672.0, 32460.675393245765, 32561.837190813894, 40754.38868417036, 40899.591004089576, 41128.0, 47454.288185677935, 47548.524514755794, 47942.76028619835, 48109.27836082392, 48306.758466207444, 39181.60818391779, 39748.00629984274, 40140.197196055335, 41875.37186942259, 42109.78945105255, 40781.59218407897, 40807.59192408038, 41188.38217426801, 42236.155276894904, 42425.78787106045, 39263.41104883372, 39540.80229598834, 40229.597704022584, 40454.1909161821, 40481.797591011855, 34354.82822585871, 36572.63427365692, 36580.0, 37063.629363706015, 37368.62631373652, 27104.45791084128, 27104.457910842066, 27276.0, 27300.86349568319, 27434.314142146606], "value": 20085.71705030042, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.0768018433638, 377.6223776223776, 384.2066133434456, 384.77875221747496, 398.98603548875775, 17605.119744012813, 19370.90314548427, 19690.90154549229, 20381.0, 20801.27195548156, 19859.10634021469, 20003.89998050008, 20331.186752529917, 20476.488087797814, 20786.0, 5093.541581257686, 5560.916586251209, 5715.657060576379, 5725.828225153231, 5776.104703770901, 4276.481848943627, 5815.38938411467, 5961.821145365624, 6275.529335299848, 6295.622262664232, 6161.445469907708, 6324.177856878622, 6357.11000459936, 6359.0, 6368.29948705642, 6577.572457790252, 6596.340365963413, 6624.933750662528, 6625.238097618787, 6627.536072474929, 5381.0583147948955, 5469.398366179717, 5521.309836270466, 5794.565407594405, 5802.854928626776, 23539.056798072426, 23674.881625591934, 23943.88028059866, 24031.87984060086, 24207.0, 2353.505763789606, 2374.1334412939327, 2430.8419952703193, 2506.0602274147195, 2520.4329025969196, 13787.586372408843, 14230.075045122034, 14284.642883927881, 14815.70368592622, 15321.693566128726, 1884.9905750471296, 1944.931927382549, 1953.2479995201807, 1975.3777560068531, 2052.8255098316513, 73727.63136184338, 75914.62042689807, 76408.99999999945, 82185.58907205485, 87075.9862615801, 10338.793224135476, 10430.0, 10563.894361056446, 10580.25938184335, 10679.65047689507, 14233.43066277358, 14248.145111293356, 14306.85693143076, 14335.713285734228, 14337.283135843167, 7795.610219489003, 7843.56860372685, 8026.879596806052, 8361.0, 8439.367047471464, 8029.75166953254, 8063.556504392314, 8166.632501537326, 8300.252977232078, 8354.248117669438, 4208.642265407413, 4311.956880431218, 4340.587644173798, 4371.103923695635, 5025.924611130836, 1816.7184086466618, 1851.1947302923272, 1858.3402891973155, 1862.3574866670976, 1874.5313671582105, 901.1754244866005, 961.3030552849128, 968.1141755293968, 978.5156347607838, 1046.895310468947, 18421.355252566365, 19888.90055549713, 19986.70019949702, 20021.0, 20084.89957550203, 939.6899023322287, 962.6871266838166, 967.8644989701447, 1008.8688470498788, 1014.974625634365, 10553.47232638365, 10984.560617575367, 11024.669259922215, 11030.613928512463, 11048.723781905517, 415935.0, 418552.7940683907, 429059.0, 429510.0, 432710.0, 53582.0, 78496.21503785004, 89510.0, 90999.0, 91628.54185729162, 972.1056627902346, 975.8194733974237, 980.4411485453223, 990.7523119220195, 1029.984550231747, 17137.828621713623, 17731.64536709233, 17944.427517519827, 18188.0, 18193.818061819213, 43127.0, 43265.24082350876, 44161.0, 44430.3335449975, 44765.689435405526, 57499.0, 57842.7107864458, 58886.0, 59426.405735942084, 59824.40175598362, 8175.468594541336, 8337.0, 8554.615042322986, 8771.736847894574, 8882.60028298741, 12910.612681619567, 13206.27365494907, 13240.602781916557, 13476.5283215087, 13589.116707413987, 10992.670219893416, 11119.0, 11311.830322545333, 11578.710532236424, 11898.0, 11352.602658906899, 11423.485943132746, 11544.538218471167, 11631.59289424866, 11696.298222106701, 5380.946190538201, 11352.716182095513, 11438.94280528592, 11547.769044619228, 11894.365563893274, 8069.0, 8218.671253149807, 8381.413301068867, 8445.071042185478, 8549.418357603863, 10292.845607316047, 10824.4046577439, 11026.779464410827, 11459.885401146215, 11636.0], "value": 9227.768591594117, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1348.5010546097944, 1478.2017710436362, 1508.0047168868546, 1639.8524132828043, 1767.7525146479495, 8355.874661880069, 8747.12528747125, 8777.03452620212, 9029.367944243906, 9119.0, 8859.955700221506, 8954.19412252897, 8964.775880602989, 8968.865467017984, 8988.0, 2084.437201955471, 2287.49675071484, 2382.28531440568, 2435.0868424340874, 2440.2191298784396, 2348.495073559184, 2372.5610762008996, 2386.7135943686694, 2391.880405979694, 2411.1801987324307, 2328.2549584133085, 2351.318117745852, 2372.1578839511985, 2376.702912135983, 2377.3581133094053, 2226.3543572363997, 2317.6755254264417, 2326.09282379872, 2333.556624241389, 2335.988320058397, 2353.870537120458, 2384.2966324934187, 2386.85678859269, 2390.6653068570413, 2393.6050551658955, 8827.602757875911, 8867.955660221722, 8908.287337013024, 8909.376343655947, 8912.420692655021, 5236.973815130938, 5340.866478338034, 5349.572034237291, 5352.116900711417, 5359.1425371940695, 3249.886253981123, 3322.700956913865, 3446.172918499567, 3493.423585108454, 3497.475378693191, 1142.5772464188303, 1176.4882276209876, 1206.4751832952693, 1228.8033914573714, 1238.7584421037902, 11941.164118511708, 12195.45120469572, 12201.877981220163, 12202.511899524008, 12244.081693872995, 4424.358468022118, 4530.411046563926, 4682.906341873144, 4704.5765881070865, 4704.647151463585, 10438.425886576159, 10452.0, 10452.268341216042, 10467.528961196764, 10478.0, 5260.210968354778, 5293.788248470018, 5296.126139186991, 5304.893902121936, 5352.785888564492, 4290.635295999875, 4635.235186194308, 4713.905721885543, 4841.467438581753, 4874.2201247800185, 3979.1047014421524, 4087.713860029829, 4148.419221309019, 4152.0, 4183.184279065614, 1296.4166125243678, 1323.2854258700386, 1342.2148043394723, 1347.9528216512374, 1357.056845492393, 793.305857374797, 841.8947631546057, 861.0743450790426, 870.7387783665002, 950.7813202963357, 5737.85655358611, 5752.856178595569, 5818.44724751148, 5884.264466941632, 6183.258009038944, 903.1149473515991, 914.8216097860986, 953.6328513522344, 957.4016239850093, 965.2471072563412, 3770.4155855842387, 3854.209886973164, 3918.8432462701744, 3959.1883663848844, 4092.7953602319767, 10923.180761442765, 11189.44052797357, 11278.323300601991, 11317.434128293553, 11321.490532926038, 11087.33475991443, 11187.272827266203, 11227.775444491064, 11322.094232461382, 11325.773484530264, 8036.638351274207, 8330.916690833135, 8385.245327920517, 8390.622421991025, 8528.829423411496, 5765.164051212634, 5925.156444306833, 5957.314908785545, 6010.579259451796, 6016.759329626941, 10334.224933130195, 10396.012378824, 10447.68656940293, 10457.372557646566, 10515.211359147941, 10001.0, 10656.360618362924, 10663.626773062906, 10664.893351066701, 10699.14406847466, 6732.596044237362, 7577.5453472791805, 7774.455788094779, 7859.646315915683, 7972.920270797218, 8376.371772117238, 8495.702650407206, 8516.361272904682, 8531.274841638531, 8533.530655813742, 7101.4673899458785, 7306.269373062863, 7361.190269070505, 7378.520396174232, 7453.478256521991, 7132.964335178291, 7170.103737032871, 7245.094363204599, 7274.672639731119, 7290.307420795016, 6674.566153200027, 6681.46548276127, 6712.9664351679885, 6731.922892337203, 6740.831479213059, 4832.057748739103, 4870.391201099863, 4881.609471242221, 4891.853244402673, 4977.0, 4884.145274577006, 4925.926111108408, 4934.753262336797, 4995.475475075064, 5110.4123025852505], "value": 4635.9992642206425, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.20269528873115, 333.2119537294299, 334.2679531825301, 336.4952571143285, 337.90707555422256, 5181.948180518194, 5264.263003179558, 5277.70972596507, 5293.15309550472, 5301.7879284828605, 5242.449542798008, 5252.52727254547, 5263.894722105556, 5271.789128434868, 5329.827437963651, 4132.462779838616, 4156.729812562174, 4164.97917510412, 4173.227952828721, 4186.832526698943, 4069.837206511736, 4169.499660040799, 4178.373244013407, 4180.393842892779, 4193.496780386358, 4130.277201489742, 4133.483314585676, 4133.503979522461, 4138.937915931248, 4169.249535083683, 4125.525564560084, 4160.167966406716, 4163.625273725349, 4175.895602609929, 4183.811728472226, 3504.316658251642, 3619.113317237294, 3625.111847597329, 3631.364511210528, 3725.6460636239512, 5074.746262686888, 5075.796968121271, 5079.492050794928, 5079.7300674831295, 5099.515546023122, 4692.55420735033, 4709.929351059737, 4715.7877895494785, 4738.4550776660435, 4757.500462451462, 5330.600204984642, 5389.353277606673, 5402.567794576425, 5411.675299482044, 5449.618526703132, 3931.174453364797, 3949.8420063197723, 3962.0094976255937, 3963.2271707017144, 3966.246413181515, 5629.536320556685, 5652.74562644682, 5693.857653558653, 5699.601027928046, 5714.599978001542, 3975.3043217436834, 4001.799910004488, 4063.6139566741113, 4073.877783666495, 4083.673306135502, 4072.775997320176, 4095.2833254180996, 4111.054457474797, 4115.855945041969, 4131.235721391552, 4643.86068417948, 4647.535246475325, 4669.626429885601, 4669.719816811003, 4717.669763116549, 5214.634975551675, 5463.2078348639225, 5481.424450432727, 5503.284573005483, 5555.916661250085, 1348.7976803479557, 1381.7650999330137, 1384.4946594492937, 1400.7478653842406, 1401.3763875075697, 941.7975135345933, 963.556763888605, 979.3351302785294, 979.985300220483, 987.9012098790064, 5214.921776173361, 5223.727678459883, 5228.55557277628, 5232.215167724796, 5239.480550640348, 5475.425080366584, 5490.752916118704, 5492.862678433071, 5504.146857237135, 5514.931900537298, 5071.46749591295, 5200.0, 5242.475752424803, 5242.868928276824, 5331.653442526223, 2924.5613158026467, 2963.9703602964128, 2965.3772707731187, 2969.8120751699494, 2973.988843793121, 5741.598088133874, 5757.568182386254, 5761.423857614289, 5772.6536407815665, 5791.362950075489, 5511.944880551143, 5652.18043383707, 5728.398518155534, 5744.425557444222, 5770.740316685759, 5776.768929242868, 5798.768049277982, 5812.6221795584, 5815.185873977646, 5856.385079566584, 5423.566114710892, 5622.915656265078, 5628.324601047901, 5648.4633959773755, 5665.235193248858, 5540.473655002768, 5604.971975140098, 5617.719114044363, 5624.634398764068, 5624.85937851557, 5834.15404766315, 5851.249912541099, 5868.004878341384, 5868.149118377897, 5873.9412605873395, 3858.9035274118373, 4070.694697897729, 4087.9167020738932, 4097.610726981051, 4102.753834769924, 5291.391489978701, 5539.390667026704, 5619.719014049199, 5646.632968857011, 5663.5469162467725, 5330.733463326741, 5432.918506222489, 5472.72636368188, 5482.23248745184, 5489.58828087903, 5428.45715428454, 5446.128619420873, 5475.2334673145, 5492.286002819608, 5505.752241149078, 5226.216067589892, 5359.973200133974, 5405.675659460445, 5427.755750991294, 5434.619576629598, 5487.984722826131, 5489.313835770528, 5489.972550137383, 5491.945080549143, 5494.708743445367, 5382.757775900172, 5402.837914862561, 5402.972985135049, 5408.945910540844, 5412.242286080031], "value": 4199.27511509611, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [741.9072615923009, 741.97774066778, 753.9057617797775, 768.0936494935977, 783.3928705253431, 14217.786733198998, 14764.630884227887, 14780.187089710062, 14780.334884930176, 14826.406943722264, 15892.52322430326, 15983.200839958014, 16028.0, 16034.919825400886, 16050.27773750181, 660.1022609251414, 782.9882551761714, 802.8394321135767, 805.3798575097171, 805.5649949027518, 673.6631684157921, 684.7089986755634, 684.7979845945433, 780.5745868501651, 803.493798906688, 825.5748289630845, 837.4305472278847, 838.4005436113177, 839.2279103225047, 839.3243439031577, 833.829065041665, 834.2491757418311, 834.4784509681449, 839.2949922065494, 839.5340585974782, 500.31207090250905, 511.94112677042244, 515.196293781698, 614.8432149801816, 615.062030403638, 13392.464301427932, 13996.72006559863, 14024.929875350557, 14471.348789304506, 14491.275436228147, 14109.858901410957, 14536.854631453656, 14835.851641483556, 14900.180490073042, 14965.0, 11855.46650400734, 11995.64013079609, 12157.635270941886, 12236.755264894653, 12301.569445069379, 3722.7394082414244, 3798.088458769875, 3813.523309586302, 3840.116773142165, 3847.384418493056, 78816.60591697063, 78890.6055469719, 80017.0, 80466.59766701187, 81638.59180704117, 11185.888141118647, 11271.605493807678, 11288.94355528217, 11410.771784564262, 11578.305301681927, 18711.345102921332, 18736.344227951955, 18761.812381876007, 18805.059747012594, 19710.21159153618, 8111.3916456266015, 8113.432059755878, 8121.431499795076, 8378.706745263886, 8382.329413646894, 4652.278896771006, 4680.3447517347595, 4696.084263568571, 4925.556699897026, 5039.69761814285, 3351.5475410819226, 3446.4141096013736, 3459.3568055174096, 3465.6361082086523, 3465.8960231193105, 582.4408567774983, 590.4420322794917, 594.5124997502094, 599.5413508665874, 599.6462087368474, 694.7464175575878, 697.417656257031, 704.7920863345325, 715.7673756029311, 720.0, 8603.956980215058, 8610.78473038179, 8656.26421754158, 8770.561471926378, 8894.332925030649, 691.9654017299115, 693.1301216972668, 712.6686090967725, 721.3255606008399, 721.3940290156294, 4017.8995525112105, 4287.421198138274, 4385.6710746694125, 4480.686351955332, 4548.226801443762, 112914.0, 118587.0, 118715.0, 119052.0, 123191.45638446113, 94570.52714736383, 98656.0, 102565.48717256366, 103927.0, 105653.62368832843, 91488.0, 92970.53514732518, 93071.53464232635, 94603.0, 94952.52523737337, 8417.200365965224, 8446.197611226924, 8550.486970781772, 8618.181272779077, 8638.870416943626, 42421.575784241766, 42647.786761065996, 44169.33745993749, 55304.72347638397, 55586.16620750611, 68321.0, 68392.6580367095, 69078.65460672665, 71196.64401677958, 75237.0, 11744.647660570197, 12013.939930300292, 12284.938575307066, 12545.31000794965, 12596.811047834106, 13928.721425571635, 14180.716385672435, 14183.574492765234, 14330.49843255481, 14453.205073721047, 12383.75232495363, 12840.229586224856, 13133.34333283351, 13427.462901483832, 14024.859751402355, 12673.619791406272, 13090.738185236432, 13095.672608184872, 13103.868961310645, 13174.670633233862, 13195.60413187606, 13255.403506842407, 13323.267220302976, 13384.130031547918, 13559.86440135586, 9564.426134431957, 9709.077637624414, 9801.411915285105, 9857.95071024669, 10141.29010969225, 9562.235021198427, 10686.358818470917, 10737.838932415863, 10820.296680715728, 10957.178211634318], "value": 7313.823603307515, "unit": "score"}], "name": "dromaeo_css", "value": 7182.182192403526, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 131.0, 111.0, 111.0, 110.0, 110.0, 110.0, 110.0, 110.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 119.0, 153.0, 180.0, 118.0, 156.0, 146.0, 124.0, 173.0, 120.0], "value": 143.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 162.0, 161.0, 163.0, 163.0, 162.0, 160.0, 161.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 177.0, 76.0, 77.0, 76.0, 76.0, 167.0, 75.0], "value": 95.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 144.0, 81.0, 81.0, 81.0, 147.0, 82.0, 81.0, 146.0], "value": 100.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 148.0, 148.0, 148.0, 147.0, 147.0, 146.0, 148.0, 147.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 94.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 52.0, 53.0, 52.0, 55.0, 54.0, 52.0, 53.0, 52.0], "value": 52.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 61.0, 62.0, 61.0, 62.0, 63.0, 62.0, 62.0], "value": 61.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 84.0, 78.0, 79.0, 86.0, 82.0, 80.0, 79.0, 78.0], "value": 80.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 139.0, 122.0, 127.0, 126.0, 138.0, 122.0, 128.0, 172.0, 125.0], "value": 134.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 161.0, 161.0, 161.0, 161.0, 158.0, 159.0, 165.0, 161.0], "value": 161.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 65.0, 67.0, 64.0, 65.0, 64.0, 65.0, 66.0, 63.0], "value": 64.7, "unit": "score"}], "name": "kraken", "value": 1528.3999999999999, "alertThreshold": 2.0}]} 06:14:25 INFO - Return code: 0 06:14:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:14:25 INFO - # TBPL SUCCESS # 06:14:25 INFO - Running post-action listener: _resource_record_post_action 06:14:25 INFO - [mozharness: 2016-08-31 13:14:25.945249Z] Finished run-tests step (success) 06:14:25 INFO - Running post-run listener: _resource_record_post_run 06:14:26 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 8192; Write bytes: 418406400; Read time: 116; Write time: 246612 06:14:26 INFO - TinderboxPrint: CPU usage
13.0% 06:14:26 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 116 06:14:26 INFO - TinderboxPrint: I/O write bytes / time
418,406,400 / 246,612 06:14:26 INFO - TinderboxPrint: CPU idle
8,289.5 (86.9%) 06:14:26 INFO - TinderboxPrint: CPU user
1,196.1 (12.5%) 06:14:26 INFO - TinderboxPrint: Swap in / out
0 / 0 06:14:26 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 129773568; Read time: 0; Write time: 64528 06:14:26 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288632832; Read time: 96; Write time: 182084 06:14:26 INFO - Running post-run listener: _upload_blobber_files 06:14:26 INFO - Blob upload gear active. 06:14:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:14:26 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 06:14:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:14:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:14:27 INFO - (blobuploader) - INFO - Open directory for files ... 06:14:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:14:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:14:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:14:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:14:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:14:28 INFO - (blobuploader) - INFO - Done attempting. 06:14:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:14:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:14:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:14:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:14:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:14:29 INFO - (blobuploader) - INFO - Done attempting. 06:14:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:14:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:14:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:14:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:14:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:14:32 INFO - (blobuploader) - INFO - Done attempting. 06:14:32 INFO - (blobuploader) - INFO - Iteration through files over. 06:14:32 INFO - Return code: 0 06:14:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:14:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:14:32 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b97980a5d588bb23c63244c89884e9dd00183e7e21596436b6f623865c6f6e4b14cca3795742a792e7c509c4b2719ee8d8278347d1848c141448c21ad698b701", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/23ecc7a12eaee0d54b5b14c45dff8590792d8f0e0baea5b17c9d8b382a74c7abce83aa2912f5cdd907131e30582756e843bd37938de31fa2a7b9c8e08e36bfed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5a83d0dc81040ccdb2a78ad4711e1aaba6b859cc2ec8431dcabd990398024a096af5b0e04c3f92cdc1e8f612dfeda50738c791b96d0fd1802467f4341165222a"} 06:14:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:14:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:14:32 INFO - Contents: 06:14:32 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b97980a5d588bb23c63244c89884e9dd00183e7e21596436b6f623865c6f6e4b14cca3795742a792e7c509c4b2719ee8d8278347d1848c141448c21ad698b701", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/23ecc7a12eaee0d54b5b14c45dff8590792d8f0e0baea5b17c9d8b382a74c7abce83aa2912f5cdd907131e30582756e843bd37938de31fa2a7b9c8e08e36bfed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5a83d0dc81040ccdb2a78ad4711e1aaba6b859cc2ec8431dcabd990398024a096af5b0e04c3f92cdc1e8f612dfeda50738c791b96d0fd1802467f4341165222a"} 06:14:32 INFO - Running post-run listener: copy_logs_to_upload_dir 06:14:32 INFO - Copying logs to upload dir... 06:14:32 INFO - mkdir: /builds/slave/test/build/upload/logs 06:14:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.122512 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-08-31 06:14:32.099091) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-31 06:14:32.102360) ========= 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=6d15e502d8e29d5d2676d664000001c3-1472647112.30423-2040620460 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b97980a5d588bb23c63244c89884e9dd00183e7e21596436b6f623865c6f6e4b14cca3795742a792e7c509c4b2719ee8d8278347d1848c141448c21ad698b701", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/23ecc7a12eaee0d54b5b14c45dff8590792d8f0e0baea5b17c9d8b382a74c7abce83aa2912f5cdd907131e30582756e843bd37938de31fa2a7b9c8e08e36bfed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5a83d0dc81040ccdb2a78ad4711e1aaba6b859cc2ec8431dcabd990398024a096af5b0e04c3f92cdc1e8f612dfeda50738c791b96d0fd1802467f4341165222a"} build_url:https://queue.taskcluster.net/v1/task/dL9IlzjXSeKC2WcGUIOEnQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011336 build_url: 'https://queue.taskcluster.net/v1/task/dL9IlzjXSeKC2WcGUIOEnQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b97980a5d588bb23c63244c89884e9dd00183e7e21596436b6f623865c6f6e4b14cca3795742a792e7c509c4b2719ee8d8278347d1848c141448c21ad698b701", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/23ecc7a12eaee0d54b5b14c45dff8590792d8f0e0baea5b17c9d8b382a74c7abce83aa2912f5cdd907131e30582756e843bd37938de31fa2a7b9c8e08e36bfed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5a83d0dc81040ccdb2a78ad4711e1aaba6b859cc2ec8431dcabd990398024a096af5b0e04c3f92cdc1e8f612dfeda50738c791b96d0fd1802467f4341165222a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-31 06:14:32.129416) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-08-31 06:14:32.129815) ========= 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=6d15e502d8e29d5d2676d664000001c3-1472647112.30423-2040620460 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004476 ========= master_lag: 1.09 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-08-31 06:14:33.219994) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-31 06:14:33.220335) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-31 06:14:33.220876) ========= ========= Total master_lag: 1.21 =========