builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-003 starttime: 1472779284.43 results: success (0) buildid: 20160901170142 builduid: 02cab5aab2a24838b41e2ab04ee0f466 revision: 4bee815089891447e819466885b771bf1db1f59a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-01 18:21:24.432024) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-01 18:21:24.432433) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-01 18:21:24.432702) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-01 18:21:24.451106) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 18:21:24.451401) ========= 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=7de08804244eb36560b44971000001c3-1472775031.950260-588082060 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-01 18:21:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.0M=0s 2016-09-01 18:21:25 (46.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.112234 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 18:21:24.584426) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 18:21:24.584862) ========= 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=7de08804244eb36560b44971000001c3-1472775031.950260-588082060 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021265 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 18:21:24.654385) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 18:21:24.654710) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4bee815089891447e819466885b771bf1db1f59a --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 4bee815089891447e819466885b771bf1db1f59a --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=7de08804244eb36560b44971000001c3-1472775031.950260-588082060 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-01 18:21:25,317 truncating revision to first 12 chars 2016-09-01 18:21:25,317 Setting DEBUG logging. 2016-09-01 18:21:25,317 attempt 1/10 2016-09-01 18:21:25,317 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4bee81508989?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-01 18:21:25,935 unpacking tar archive at: mozilla-central-4bee81508989/testing/mozharness/ program finished with exit code 0 elapsedTime=0.948886 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 18:21:25.619267) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-01 18:21:25.619577) ========= script_repo_revision: 4bee815089891447e819466885b771bf1db1f59a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-01 18:21:25.619963) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-01 18:21:25.620247) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-01 18:21:25.629026) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-09-01 18:21:25.629357) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7de08804244eb36560b44971000001c3-1472775031.950260-588082060 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:21:26 INFO - MultiFileLogger online at 20160901 18:21:26 in /builds/slave/test 18:21:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 18:21:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:21:26 INFO - {'append_to_log': False, 18:21:26 INFO - 'base_work_dir': '/builds/slave/test', 18:21:26 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 18:21:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:21:26 INFO - 'branch': 'Firefox-Non-PGO', 18:21:26 INFO - 'buildbot_json_path': 'buildprops.json', 18:21:26 INFO - 'config_files': ('talos/linux_config.py',), 18:21:26 INFO - 'default_actions': ('clobber', 18:21:26 INFO - 'read-buildbot-config', 18:21:26 INFO - 'download-and-extract', 18:21:26 INFO - 'populate-webroot', 18:21:26 INFO - 'create-virtualenv', 18:21:26 INFO - 'install', 18:21:26 INFO - 'run-tests'), 18:21:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:21:26 INFO - 'download_minidump_stackwalk': True, 18:21:26 INFO - 'download_symbols': 'ondemand', 18:21:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:21:26 INFO - 'tooltool.py': '/tools/tooltool.py', 18:21:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:21:26 INFO - '/tools/misc-python/virtualenv.py')}, 18:21:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:21:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:21:26 INFO - 'installer_path': 'installer.exe', 18:21:26 INFO - 'log_level': 'info', 18:21:26 INFO - 'log_name': 'talos', 18:21:26 INFO - 'log_to_console': True, 18:21:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:21:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:21:26 INFO - 'opt_config_files': (), 18:21:26 INFO - 'pip_index': False, 18:21:26 INFO - 'sps_profile': False, 18:21:26 INFO - 'sps_profile_interval': 0, 18:21:26 INFO - 'suite': 'dromaeojs', 18:21:26 INFO - 'system_bits': '32', 18:21:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:21:26 INFO - 'title': 'talos-linux64-ix-003', 18:21:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:21:26 INFO - 'use_talos_json': True, 18:21:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:21:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:21:26 INFO - 'work_dir': 'build'} 18:21:26 INFO - [mozharness: 2016-09-02 01:21:26.386215Z] Running clobber step. 18:21:26 INFO - Running pre-action listener: _resource_record_pre_action 18:21:26 INFO - Running main action method: clobber 18:21:26 INFO - rmtree: /builds/slave/test/build 18:21:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:21:26 INFO - Running post-action listener: _resource_record_post_action 18:21:26 INFO - [mozharness: 2016-09-02 01:21:26.842163Z] Finished clobber step (success) 18:21:26 INFO - [mozharness: 2016-09-02 01:21:26.842264Z] Running read-buildbot-config step. 18:21:26 INFO - Running pre-action listener: _resource_record_pre_action 18:21:26 INFO - Running main action method: read_buildbot_config 18:21:26 INFO - Using buildbot properties: 18:21:26 INFO - { 18:21:26 INFO - "project": "", 18:21:26 INFO - "product": "firefox", 18:21:26 INFO - "script_repo_revision": "production", 18:21:26 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 18:21:26 INFO - "repository": "", 18:21:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 18:21:26 INFO - "buildid": "20160901170142", 18:21:26 INFO - "pgo_build": "False", 18:21:26 INFO - "basedir": "/builds/slave/test", 18:21:26 INFO - "buildnumber": 201, 18:21:26 INFO - "slavename": "talos-linux64-ix-003", 18:21:26 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:21:26 INFO - "platform": "ubuntu64_hw", 18:21:26 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 18:21:26 INFO - "branch": "mozilla-central", 18:21:26 INFO - "repo_path": "mozilla-central", 18:21:26 INFO - "revision": "4bee815089891447e819466885b771bf1db1f59a", 18:21:26 INFO - "stage_platform": "linux64", 18:21:26 INFO - "builduid": "02cab5aab2a24838b41e2ab04ee0f466", 18:21:26 INFO - "slavebuilddir": "test" 18:21:26 INFO - } 18:21:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/bsVgSYJRQNq2IAukgZ7Clw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 18:21:26 INFO - Running post-action listener: _resource_record_post_action 18:21:26 INFO - [mozharness: 2016-09-02 01:21:26.844714Z] Finished read-buildbot-config step (success) 18:21:26 INFO - [mozharness: 2016-09-02 01:21:26.844805Z] Running download-and-extract step. 18:21:26 INFO - Running pre-action listener: _resource_record_pre_action 18:21:26 INFO - Running main action method: download_and_extract 18:21:26 INFO - mkdir: /builds/slave/test/build/tests 18:21: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')]} 18:21:26 INFO - trying https://queue.taskcluster.net/v1/task/bsVgSYJRQNq2IAukgZ7Clw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 18:21:26 INFO - Downloading https://queue.taskcluster.net/v1/task/bsVgSYJRQNq2IAukgZ7Clw/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 18:21:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bsVgSYJRQNq2IAukgZ7Clw/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 18:21:27 INFO - Downloaded 1361 bytes. 18:21:27 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 18:21:27 INFO - Using the following test package requirements: 18:21:27 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 18:21:27 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:21:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:21:27 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:21:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:21:27 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:21:27 INFO - u'jsshell-linux-x86_64.zip'], 18:21:27 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:21:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:21:27 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 18:21:27 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:21:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:21:27 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:21:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:21:27 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:21:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:21:27 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:21:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:21:27 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:21:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:21:27 INFO - trying https://queue.taskcluster.net/v1/task/bsVgSYJRQNq2IAukgZ7Clw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 18:21:27 INFO - Downloading https://queue.taskcluster.net/v1/task/bsVgSYJRQNq2IAukgZ7Clw/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 18:21:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bsVgSYJRQNq2IAukgZ7Clw/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 18:21:28 INFO - Downloaded 20334479 bytes. 18:21:28 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 18:21:32 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 18:21:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:21:32 INFO - trying https://queue.taskcluster.net/v1/task/bsVgSYJRQNq2IAukgZ7Clw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 18:21:32 INFO - Downloading https://queue.taskcluster.net/v1/task/bsVgSYJRQNq2IAukgZ7Clw/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 18:21:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bsVgSYJRQNq2IAukgZ7Clw/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 18:21:33 INFO - Downloaded 20334479 bytes. 18:21:33 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 18:21:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:21:38 INFO - trying https://queue.taskcluster.net/v1/task/bsVgSYJRQNq2IAukgZ7Clw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 18:21:38 INFO - Downloading https://queue.taskcluster.net/v1/task/bsVgSYJRQNq2IAukgZ7Clw/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 18:21:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bsVgSYJRQNq2IAukgZ7Clw/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 18:21:39 INFO - Downloaded 14413998 bytes. 18:21:39 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 18:21:40 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')]} 18:21:40 INFO - trying https://queue.taskcluster.net/v1/task/bsVgSYJRQNq2IAukgZ7Clw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 18:21:40 INFO - Downloading https://queue.taskcluster.net/v1/task/bsVgSYJRQNq2IAukgZ7Clw/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 18:21:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bsVgSYJRQNq2IAukgZ7Clw/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 18:21:41 INFO - Downloaded 55870683 bytes. 18:21:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bsVgSYJRQNq2IAukgZ7Clw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 18:21:41 INFO - mkdir: /builds/slave/test/properties 18:21:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:21:41 INFO - Writing to file /builds/slave/test/properties/build_url 18:21:41 INFO - Contents: 18:21:41 INFO - build_url:https://queue.taskcluster.net/v1/task/bsVgSYJRQNq2IAukgZ7Clw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 18:21:41 INFO - Running post-action listener: _resource_record_post_action 18:21:41 INFO - Running post-action listener: set_extra_try_arguments 18:21:42 INFO - [mozharness: 2016-09-02 01:21:42.000123Z] Finished download-and-extract step (success) 18:21:42 INFO - [mozharness: 2016-09-02 01:21:42.000351Z] Running populate-webroot step. 18:21:42 INFO - Running pre-action listener: _resource_record_pre_action 18:21:42 INFO - Running main action method: populate_webroot 18:21:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:21:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:21:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:21:42 INFO - '--tppagecycles', 18:21:42 INFO - '7'], 18:21:42 INFO - 'tests': ['tsvgm']}}, 18:21:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:21:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:21:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:21:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:21:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:21:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:21:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:21:42 INFO - 'talos_options': ['--disable-e10s'], 18:21:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:21:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:21:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:21:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:21:42 INFO - 'talos_options': ['--disable-e10s'], 18:21:42 INFO - 'tests': ['damp', 'tps']}, 18:21:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:21:42 INFO - 'tests': ['damp', 'tps']}, 18:21:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:21:42 INFO - 'tests': ['dromaeo_dom']}, 18:21:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:21:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:21:42 INFO - 'tests': ['basic_compositor_video']}, 18:21:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:21:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:21:42 INFO - 'tests': ['a11yr', 18:21:42 INFO - 'ts_paint', 18:21:42 INFO - 'tpaint', 18:21:42 INFO - 'sessionrestore', 18:21:42 INFO - 'sessionrestore_no_auto_restore', 18:21:42 INFO - 'tabpaint']}, 18:21:42 INFO - 'other-e10s': {'tests': ['a11yr', 18:21:42 INFO - 'ts_paint', 18:21:42 INFO - 'tpaint', 18:21:42 INFO - 'sessionrestore', 18:21:42 INFO - 'sessionrestore_no_auto_restore', 18:21:42 INFO - 'tabpaint']}, 18:21:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:21:42 INFO - 'ts_paint', 18:21:42 INFO - 'tpaint', 18:21:42 INFO - 'sessionrestore', 18:21:42 INFO - 'sessionrestore_no_auto_restore', 18:21:42 INFO - 'tabpaint']}, 18:21:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:21:42 INFO - 'ts_paint', 18:21:42 INFO - 'tpaint', 18:21:42 INFO - 'sessionrestore', 18:21:42 INFO - 'sessionrestore_no_auto_restore', 18:21:42 INFO - 'tabpaint']}, 18:21:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:21:42 INFO - 'tests': ['a11yr', 18:21:42 INFO - 'ts_paint', 18:21:42 INFO - 'tpaint', 18:21:42 INFO - 'sessionrestore', 18:21:42 INFO - 'sessionrestore_no_auto_restore', 18:21:42 INFO - 'tabpaint']}, 18:21:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:21:42 INFO - 'tests': ['a11yr', 18:21:42 INFO - 'ts_paint', 18:21:42 INFO - 'tpaint', 18:21:42 INFO - 'sessionrestore', 18:21:42 INFO - 'sessionrestore_no_auto_restore', 18:21:42 INFO - 'tabpaint']}, 18:21:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:21:42 INFO - 'tests': ['tsvgx', 18:21:42 INFO - 'tsvgr_opacity', 18:21:42 INFO - 'tart', 18:21:42 INFO - 'tscrollx', 18:21:42 INFO - 'cart']}, 18:21:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:21:42 INFO - 'tsvgr_opacity', 18:21:42 INFO - 'tart', 18:21:42 INFO - 'tscrollx', 18:21:42 INFO - 'cart']}, 18:21:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:21:42 INFO - 'talos_options': ['--disable-e10s'], 18:21:42 INFO - 'tests': ['tp5o']}, 18:21:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:21:42 INFO - 'tests': ['tp5o']}, 18:21:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:21:42 INFO - 'talos_options': ['--disable-e10s', 18:21:42 INFO - '--xperf_path', 18:21:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:21:42 INFO - 'tests': ['tp5n']}, 18:21:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:21:42 INFO - 'talos_options': ['--xperf_path', 18:21:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:21:42 INFO - 'tests': ['tp5n']}}, 18:21:42 INFO - 'talos.zip': {'path': '', 18:21:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:21:42 INFO - Running post-action listener: _resource_record_post_action 18:21:42 INFO - [mozharness: 2016-09-02 01:21:42.018878Z] Finished populate-webroot step (success) 18:21:42 INFO - [mozharness: 2016-09-02 01:21:42.018968Z] Running create-virtualenv step. 18:21:42 INFO - Running pre-action listener: _resource_record_pre_action 18:21:42 INFO - Running main action method: create_virtualenv 18:21:42 INFO - Creating virtualenv /builds/slave/test/build/venv 18:21:42 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 18:21:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:21:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:21:42 INFO - Using real prefix '/usr' 18:21:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:21:42 INFO - Installing distribute.............................................................................................................................................................................................done. 18:21:44 INFO - Installing pip.................done. 18:21:44 INFO - Return code: 0 18:21:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:21:44 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')]} 18:21:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:21:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:44 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')]} 18:21:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:21:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:44 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 0x7ff1aca87f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2557420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e5d20>, '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 0x25e6c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e70b0>, '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': '7de08804244eb36560b44971000001c3-1472775031.950260-588082060', '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 18:21:44 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 18:21:44 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 18:21:44 INFO - Using env: {'DISPLAY': ':0', 18:21:44 INFO - 'HOME': '/home/cltbld', 18:21:44 INFO - 'LANG': 'en_US.UTF-8', 18:21:44 INFO - 'LANGUAGE': 'en_US:en', 18:21:44 INFO - 'LOGNAME': 'cltbld', 18:21:44 INFO - 'MAIL': '/var/mail/cltbld', 18:21:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:44 INFO - 'MOZ_NO_REMOTE': '1', 18:21:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:21:44 INFO - 'NO_EM_RESTART': '1', 18:21:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:21:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:21:44 INFO - 'PWD': '/builds/slave/test', 18:21:44 INFO - 'SHELL': '/bin/bash', 18:21:44 INFO - 'SHLVL': '1', 18:21:44 INFO - 'TERM': 'linux', 18:21:44 INFO - 'TMOUT': '86400', 18:21:44 INFO - 'USER': 'cltbld', 18:21:44 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1472775031.950260-588082060', 18:21:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:44 INFO - '_': '/tools/buildbot/bin/python'} 18:21:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:21:44 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 18:21:44 INFO - Cleaning up... 18:21:44 INFO - Return code: 0 18:21:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:21:44 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')]} 18:21:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:21:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:44 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')]} 18:21:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:21:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:44 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 0x7ff1aca87f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2557420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e5d20>, '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 0x25e6c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e70b0>, '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': '7de08804244eb36560b44971000001c3-1472775031.950260-588082060', '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 18:21:44 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 18:21:44 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 18:21:44 INFO - Using env: {'DISPLAY': ':0', 18:21:44 INFO - 'HOME': '/home/cltbld', 18:21:44 INFO - 'LANG': 'en_US.UTF-8', 18:21:44 INFO - 'LANGUAGE': 'en_US:en', 18:21:44 INFO - 'LOGNAME': 'cltbld', 18:21:44 INFO - 'MAIL': '/var/mail/cltbld', 18:21:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:44 INFO - 'MOZ_NO_REMOTE': '1', 18:21:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:21:44 INFO - 'NO_EM_RESTART': '1', 18:21:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:21:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:21:44 INFO - 'PWD': '/builds/slave/test', 18:21:44 INFO - 'SHELL': '/bin/bash', 18:21:44 INFO - 'SHLVL': '1', 18:21:44 INFO - 'TERM': 'linux', 18:21:44 INFO - 'TMOUT': '86400', 18:21:44 INFO - 'USER': 'cltbld', 18:21:44 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1472775031.950260-588082060', 18:21:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:44 INFO - '_': '/tools/buildbot/bin/python'} 18:21:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:21:45 INFO - Downloading/unpacking psutil>=3.1.1 18:21:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:21:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:21:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:21:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:21:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:21:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:21:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:21:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:21:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:21:46 INFO - Installing collected packages: psutil 18:21:46 INFO - Running setup.py install for psutil 18:21:47 INFO - building 'psutil._psutil_linux' extension 18:21:47 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 18:21:47 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 18:21:47 INFO - building 'psutil._psutil_posix' extension 18:21:47 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 18:21:47 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 18:21:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:21:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:21:47 INFO - Successfully installed psutil 18:21:47 INFO - Cleaning up... 18:21:47 INFO - Return code: 0 18:21:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:21: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')]} 18:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:21:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21: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')]} 18:21:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:21:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1aca87f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2557420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e5d20>, '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 0x25e6c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e70b0>, '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': '7de08804244eb36560b44971000001c3-1472775031.950260-588082060', '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 18:21:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:21:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:21:47 INFO - Using env: {'DISPLAY': ':0', 18:21:47 INFO - 'HOME': '/home/cltbld', 18:21:47 INFO - 'LANG': 'en_US.UTF-8', 18:21:47 INFO - 'LANGUAGE': 'en_US:en', 18:21:47 INFO - 'LOGNAME': 'cltbld', 18:21:47 INFO - 'MAIL': '/var/mail/cltbld', 18:21:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:47 INFO - 'MOZ_NO_REMOTE': '1', 18:21:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:21:47 INFO - 'NO_EM_RESTART': '1', 18:21:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:21:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:21:47 INFO - 'PWD': '/builds/slave/test', 18:21:47 INFO - 'SHELL': '/bin/bash', 18:21:47 INFO - 'SHLVL': '1', 18:21:47 INFO - 'TERM': 'linux', 18:21:47 INFO - 'TMOUT': '86400', 18:21:47 INFO - 'USER': 'cltbld', 18:21:47 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1472775031.950260-588082060', 18:21:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:47 INFO - '_': '/tools/buildbot/bin/python'} 18:21:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:21:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:21:47 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 18:21:47 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 18:21:47 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 18:21:47 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 18:21:47 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 18:21:47 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 18:21:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:21:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:21:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:21:49 INFO - Installing collected packages: mozsystemmonitor 18:21:49 INFO - Running setup.py install for mozsystemmonitor 18:21:49 INFO - Successfully installed mozsystemmonitor 18:21:49 INFO - Cleaning up... 18:21:49 INFO - Return code: 0 18:21:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:21:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:21:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:21:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:21:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:21:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:49 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 0x7ff1aca87f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2557420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e5d20>, '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 0x25e6c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e70b0>, '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': '7de08804244eb36560b44971000001c3-1472775031.950260-588082060', '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 18:21:49 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 18:21:49 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 18:21:49 INFO - Using env: {'DISPLAY': ':0', 18:21:49 INFO - 'HOME': '/home/cltbld', 18:21:49 INFO - 'LANG': 'en_US.UTF-8', 18:21:49 INFO - 'LANGUAGE': 'en_US:en', 18:21:49 INFO - 'LOGNAME': 'cltbld', 18:21:49 INFO - 'MAIL': '/var/mail/cltbld', 18:21:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:49 INFO - 'MOZ_NO_REMOTE': '1', 18:21:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:21:49 INFO - 'NO_EM_RESTART': '1', 18:21:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:21:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:21:49 INFO - 'PWD': '/builds/slave/test', 18:21:49 INFO - 'SHELL': '/bin/bash', 18:21:49 INFO - 'SHLVL': '1', 18:21:49 INFO - 'TERM': 'linux', 18:21:49 INFO - 'TMOUT': '86400', 18:21:49 INFO - 'USER': 'cltbld', 18:21:49 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1472775031.950260-588082060', 18:21:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:49 INFO - '_': '/tools/buildbot/bin/python'} 18:21:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:21:50 INFO - Downloading/unpacking jsonschema==2.5.1 18:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:21:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:21:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:21:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:21:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:21:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:21:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:21:51 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 18:21:51 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 18:21:51 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 18:21:51 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 18:21:51 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 18:21:51 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 18:21:52 INFO - Downloading functools32-3.2.3-2.tar.gz 18:21:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:21:52 INFO - warning: no files found matching '*.txt' 18:21:52 INFO - no previously-included directories found matching 'build' 18:21:52 INFO - no previously-included directories found matching 'dist' 18:21:52 INFO - no previously-included directories found matching '.git*' 18:21:52 INFO - Installing collected packages: jsonschema, functools32 18:21:52 INFO - Running setup.py install for functools32 18:21:52 INFO - warning: no files found matching '*.txt' 18:21:52 INFO - no previously-included directories found matching 'build' 18:21:52 INFO - no previously-included directories found matching 'dist' 18:21:52 INFO - no previously-included directories found matching '.git*' 18:21:52 INFO - Successfully installed jsonschema functools32 18:21:52 INFO - Cleaning up... 18:21:52 INFO - Return code: 0 18:21:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:21:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:21:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:21:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:21:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:52 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 0x7ff1aca87f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2557420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e5d20>, '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 0x25e6c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e70b0>, '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': '7de08804244eb36560b44971000001c3-1472775031.950260-588082060', '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 18:21:52 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 18:21:52 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 18:21:52 INFO - Using env: {'DISPLAY': ':0', 18:21:52 INFO - 'HOME': '/home/cltbld', 18:21:52 INFO - 'LANG': 'en_US.UTF-8', 18:21:52 INFO - 'LANGUAGE': 'en_US:en', 18:21:52 INFO - 'LOGNAME': 'cltbld', 18:21:52 INFO - 'MAIL': '/var/mail/cltbld', 18:21:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:52 INFO - 'MOZ_NO_REMOTE': '1', 18:21:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:21:52 INFO - 'NO_EM_RESTART': '1', 18:21:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:21:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:21:52 INFO - 'PWD': '/builds/slave/test', 18:21:52 INFO - 'SHELL': '/bin/bash', 18:21:52 INFO - 'SHLVL': '1', 18:21:52 INFO - 'TERM': 'linux', 18:21:52 INFO - 'TMOUT': '86400', 18:21:52 INFO - 'USER': 'cltbld', 18:21:52 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1472775031.950260-588082060', 18:21:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:52 INFO - '_': '/tools/buildbot/bin/python'} 18:21:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:21:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:21:52 INFO - Cleaning up... 18:21:52 INFO - Return code: 0 18:21:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:21:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:21:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:21:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:21:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:52 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 0x7ff1aca87f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2557420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e5d20>, '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 0x25e6c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e70b0>, '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': '7de08804244eb36560b44971000001c3-1472775031.950260-588082060', '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 18:21:52 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 18:21:52 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 18:21:52 INFO - Using env: {'DISPLAY': ':0', 18:21:52 INFO - 'HOME': '/home/cltbld', 18:21:52 INFO - 'LANG': 'en_US.UTF-8', 18:21:52 INFO - 'LANGUAGE': 'en_US:en', 18:21:52 INFO - 'LOGNAME': 'cltbld', 18:21:52 INFO - 'MAIL': '/var/mail/cltbld', 18:21:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:52 INFO - 'MOZ_NO_REMOTE': '1', 18:21:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:21:52 INFO - 'NO_EM_RESTART': '1', 18:21:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:21:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:21:52 INFO - 'PWD': '/builds/slave/test', 18:21:52 INFO - 'SHELL': '/bin/bash', 18:21:52 INFO - 'SHLVL': '1', 18:21:52 INFO - 'TERM': 'linux', 18:21:52 INFO - 'TMOUT': '86400', 18:21:52 INFO - 'USER': 'cltbld', 18:21:52 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1472775031.950260-588082060', 18:21:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:52 INFO - '_': '/tools/buildbot/bin/python'} 18:21:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:21:52 INFO - Downloading/unpacking blobuploader==1.2.4 18:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:21:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:21:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:21:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:21:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:21:54 INFO - Downloading blobuploader-1.2.4.tar.gz 18:21:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:21:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:21:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:21:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:21:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:21:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:21:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:21:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:21:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:21:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:21:55 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 18:21:55 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 18:21:55 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 18:21:55 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 18:21:55 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 18:21:55 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 18:21:55 INFO - Downloading docopt-0.6.1.tar.gz 18:21:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:21:55 INFO - Installing collected packages: blobuploader, requests, docopt 18:21:55 INFO - Running setup.py install for blobuploader 18:21:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:21:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:21:55 INFO - Running setup.py install for requests 18:21:55 INFO - Running setup.py install for docopt 18:21:55 INFO - Successfully installed blobuploader requests docopt 18:21:55 INFO - Cleaning up... 18:21:56 INFO - Return code: 0 18:21:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:21:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:21:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:21:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:21:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:21:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:56 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 0x7ff1aca87f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2557420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e5d20>, '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 0x25e6c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e70b0>, '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': '7de08804244eb36560b44971000001c3-1472775031.950260-588082060', '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 18:21:56 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 18:21:56 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 18:21:56 INFO - Using env: {'DISPLAY': ':0', 18:21:56 INFO - 'HOME': '/home/cltbld', 18:21:56 INFO - 'LANG': 'en_US.UTF-8', 18:21:56 INFO - 'LANGUAGE': 'en_US:en', 18:21:56 INFO - 'LOGNAME': 'cltbld', 18:21:56 INFO - 'MAIL': '/var/mail/cltbld', 18:21:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:56 INFO - 'MOZ_NO_REMOTE': '1', 18:21:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:21:56 INFO - 'NO_EM_RESTART': '1', 18:21:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:21:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:21:56 INFO - 'PWD': '/builds/slave/test', 18:21:56 INFO - 'SHELL': '/bin/bash', 18:21:56 INFO - 'SHLVL': '1', 18:21:56 INFO - 'TERM': 'linux', 18:21:56 INFO - 'TMOUT': '86400', 18:21:56 INFO - 'USER': 'cltbld', 18:21:56 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1472775031.950260-588082060', 18:21:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:56 INFO - '_': '/tools/buildbot/bin/python'} 18:21:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:21:56 INFO - Running setup.py (path:/tmp/pip-jEQBqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:21:56 INFO - Running setup.py (path:/tmp/pip-CrNsR0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:21:56 INFO - Running setup.py (path:/tmp/pip-lAVOAp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:21:56 INFO - Running setup.py (path:/tmp/pip-AyKMwU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:21:56 INFO - Running setup.py (path:/tmp/pip-DpzyRL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:21:56 INFO - Running setup.py (path:/tmp/pip-CNAyyu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:21:56 INFO - Running setup.py (path:/tmp/pip-hVGukn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:21:56 INFO - Running setup.py (path:/tmp/pip-IILfUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:21:56 INFO - Running setup.py (path:/tmp/pip-Gus_rM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:21:56 INFO - Running setup.py (path:/tmp/pip-GiwSi8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:21:56 INFO - Running setup.py (path:/tmp/pip-utOR7t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:21:57 INFO - Running setup.py (path:/tmp/pip-4QxQ7Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:21:57 INFO - Running setup.py (path:/tmp/pip-QmHbB4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:21:57 INFO - Running setup.py (path:/tmp/pip-SAvICo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:21:57 INFO - Running setup.py (path:/tmp/pip-e476cx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:21:57 INFO - Running setup.py (path:/tmp/pip-3W5GUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:21:57 INFO - Running setup.py (path:/tmp/pip-ip_gHc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:21:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:21:57 INFO - Running setup.py install for manifestparser 18:21:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:21:57 INFO - Running setup.py install for mozcrash 18:21:57 INFO - Running setup.py install for mozdebug 18:21:57 INFO - Running setup.py install for mozdevice 18:21:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:21:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:21:57 INFO - Running setup.py install for mozfile 18:21:58 INFO - Running setup.py install for mozhttpd 18:21:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:21:58 INFO - Running setup.py install for mozinfo 18:21:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:21:58 INFO - Running setup.py install for mozInstall 18:21:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:21:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:21:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:21:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:21:58 INFO - Running setup.py install for mozleak 18:21:58 INFO - Running setup.py install for mozlog 18:21:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:21:58 INFO - Running setup.py install for moznetwork 18:21:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:21:58 INFO - Running setup.py install for mozprocess 18:21:58 INFO - Running setup.py install for mozprofile 18:21:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:21:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:21:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:21:58 INFO - Running setup.py install for mozrunner 18:21:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:21:58 INFO - Running setup.py install for mozscreenshot 18:21:59 INFO - Running setup.py install for moztest 18:21:59 INFO - Running setup.py install for mozversion 18:21:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:21:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:21:59 INFO - Cleaning up... 18:21:59 INFO - Return code: 0 18:21:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:21: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')]} 18:21:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:21:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21: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')]} 18:21:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:21:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:59 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 0x7ff1aca87f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2557420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e5d20>, '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 0x25e6c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e70b0>, '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': '7de08804244eb36560b44971000001c3-1472775031.950260-588082060', '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 18:21:59 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 18:21:59 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 18:21:59 INFO - Using env: {'DISPLAY': ':0', 18:21:59 INFO - 'HOME': '/home/cltbld', 18:21:59 INFO - 'LANG': 'en_US.UTF-8', 18:21:59 INFO - 'LANGUAGE': 'en_US:en', 18:21:59 INFO - 'LOGNAME': 'cltbld', 18:21:59 INFO - 'MAIL': '/var/mail/cltbld', 18:21:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:59 INFO - 'MOZ_NO_REMOTE': '1', 18:21:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:21:59 INFO - 'NO_EM_RESTART': '1', 18:21:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:21:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:21:59 INFO - 'PWD': '/builds/slave/test', 18:21:59 INFO - 'SHELL': '/bin/bash', 18:21:59 INFO - 'SHLVL': '1', 18:21:59 INFO - 'TERM': 'linux', 18:21:59 INFO - 'TMOUT': '86400', 18:21:59 INFO - 'USER': 'cltbld', 18:21:59 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1472775031.950260-588082060', 18:21:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:59 INFO - '_': '/tools/buildbot/bin/python'} 18:21:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:21:59 INFO - Running setup.py (path:/tmp/pip-YMvt1q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:21:59 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)) 18:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:21:59 INFO - Running setup.py (path:/tmp/pip-jlYRDL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:21:59 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)) 18:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:21:59 INFO - Running setup.py (path:/tmp/pip-ehVtPQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:21:59 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)) 18:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:21:59 INFO - Running setup.py (path:/tmp/pip-m5XPZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:21:59 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)) 18:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:21:59 INFO - Running setup.py (path:/tmp/pip-OCQ2KB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:21:59 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)) 18:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:21:59 INFO - Running setup.py (path:/tmp/pip-ObQDxg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:21:59 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)) 18:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:21:59 INFO - Running setup.py (path:/tmp/pip-lJrCAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:22:00 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)) 18:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:22:00 INFO - Running setup.py (path:/tmp/pip-Y8eS8R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:22:00 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)) 18:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:22:00 INFO - Running setup.py (path:/tmp/pip-f_XOoQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:22:00 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)) 18:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:22:00 INFO - Running setup.py (path:/tmp/pip-jbDdeI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:22:00 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)) 18:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:22:00 INFO - Running setup.py (path:/tmp/pip-Uk5i52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:22:00 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)) 18:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:22:00 INFO - Running setup.py (path:/tmp/pip-fx7VGo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:22:00 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)) 18:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:22:00 INFO - Running setup.py (path:/tmp/pip-DtL0VL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:22:00 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)) 18:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:22:00 INFO - Running setup.py (path:/tmp/pip-0z8mNU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:22:00 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)) 18:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:22:00 INFO - Running setup.py (path:/tmp/pip-UcQB6R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:22:00 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)) 18:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:22:00 INFO - Running setup.py (path:/tmp/pip-p8BrQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:22:00 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)) 18:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:22:00 INFO - Running setup.py (path:/tmp/pip-XXE2Hh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:22:00 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)) 18:22:00 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)) 18:22:00 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)) 18:22:00 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)) 18:22:00 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)) 18:22:00 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)) 18:22:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:22:00 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 18:22:00 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 18:22:00 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 18:22:00 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 18:22:00 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 18:22:00 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 18:22:02 INFO - Downloading blessings-1.6.tar.gz 18:22:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:22:02 INFO - Installing collected packages: blessings 18:22:02 INFO - Running setup.py install for blessings 18:22:02 INFO - Successfully installed blessings 18:22:02 INFO - Cleaning up... 18:22:02 INFO - Return code: 0 18:22:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:22:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:22:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:22:03 INFO - Reading from file tmpfile_stdout 18:22:03 INFO - Current package versions: 18:22:03 INFO - argparse == 1.2.1 18:22:03 INFO - blessings == 1.6 18:22:03 INFO - blobuploader == 1.2.4 18:22:03 INFO - docopt == 0.6.1 18:22:03 INFO - functools32 == 3.2.3-2 18:22:03 INFO - jsonschema == 2.5.1 18:22:03 INFO - manifestparser == 1.1 18:22:03 INFO - mozInstall == 1.12 18:22:03 INFO - mozcrash == 0.17 18:22:03 INFO - mozdebug == 0.1 18:22:03 INFO - mozdevice == 0.48 18:22:03 INFO - mozfile == 1.2 18:22:03 INFO - mozhttpd == 0.7 18:22:03 INFO - mozinfo == 0.9 18:22:03 INFO - mozleak == 0.1 18:22:03 INFO - mozlog == 3.3 18:22:03 INFO - moznetwork == 0.27 18:22:03 INFO - mozprocess == 0.23 18:22:03 INFO - mozprofile == 0.28 18:22:03 INFO - mozrunner == 6.12 18:22:03 INFO - mozscreenshot == 0.1 18:22:03 INFO - mozsystemmonitor == 0.3 18:22:03 INFO - moztest == 0.7 18:22:03 INFO - mozversion == 1.4 18:22:03 INFO - psutil == 3.1.1 18:22:03 INFO - requests == 1.2.3 18:22:03 INFO - wsgiref == 0.1.2 18:22:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:22:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:22:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:22:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:22:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:22:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:03 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 0x7ff1aca87f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2557420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e5d20>, '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 0x25e6c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e70b0>, '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': '7de08804244eb36560b44971000001c3-1472775031.950260-588082060', '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 18:22:03 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 18:22:03 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 18:22:03 INFO - Using env: {'DISPLAY': ':0', 18:22:03 INFO - 'HOME': '/home/cltbld', 18:22:03 INFO - 'LANG': 'en_US.UTF-8', 18:22:03 INFO - 'LANGUAGE': 'en_US:en', 18:22:03 INFO - 'LOGNAME': 'cltbld', 18:22:03 INFO - 'MAIL': '/var/mail/cltbld', 18:22:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:22:03 INFO - 'MOZ_NO_REMOTE': '1', 18:22:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:22:03 INFO - 'NO_EM_RESTART': '1', 18:22:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:22:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:22:03 INFO - 'PWD': '/builds/slave/test', 18:22:03 INFO - 'SHELL': '/bin/bash', 18:22:03 INFO - 'SHLVL': '1', 18:22:03 INFO - 'TERM': 'linux', 18:22:03 INFO - 'TMOUT': '86400', 18:22:03 INFO - 'USER': 'cltbld', 18:22:03 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1472775031.950260-588082060', 18:22:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:22:03 INFO - '_': '/tools/buildbot/bin/python'} 18:22:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:22:03 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)) 18:22:03 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)) 18:22:03 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)) 18:22:03 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)) 18:22:03 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)) 18:22:03 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)) 18:22:03 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)) 18:22:03 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)) 18:22:03 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)) 18:22:03 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)) 18:22:03 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)) 18:22:03 INFO - Cleaning up... 18:22:03 INFO - Return code: 0 18:22:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:22:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:22:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:22:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:22:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:22:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:03 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 0x7ff1aca87f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2557420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e5d20>, '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 0x25e6c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e70b0>, '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': '7de08804244eb36560b44971000001c3-1472775031.950260-588082060', '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 18:22:03 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 18:22:03 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 18:22:03 INFO - Using env: {'DISPLAY': ':0', 18:22:03 INFO - 'HOME': '/home/cltbld', 18:22:03 INFO - 'LANG': 'en_US.UTF-8', 18:22:03 INFO - 'LANGUAGE': 'en_US:en', 18:22:03 INFO - 'LOGNAME': 'cltbld', 18:22:03 INFO - 'MAIL': '/var/mail/cltbld', 18:22:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:22:03 INFO - 'MOZ_NO_REMOTE': '1', 18:22:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:22:03 INFO - 'NO_EM_RESTART': '1', 18:22:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:22:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:22:03 INFO - 'PWD': '/builds/slave/test', 18:22:03 INFO - 'SHELL': '/bin/bash', 18:22:03 INFO - 'SHLVL': '1', 18:22:03 INFO - 'TERM': 'linux', 18:22:03 INFO - 'TMOUT': '86400', 18:22:03 INFO - 'USER': 'cltbld', 18:22:03 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1472775031.950260-588082060', 18:22:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:22:03 INFO - '_': '/tools/buildbot/bin/python'} 18:22:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:22:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:22:03 INFO - Cleaning up... 18:22:03 INFO - Return code: 0 18:22:03 INFO - Running post-action listener: _resource_record_post_action 18:22:03 INFO - Running post-action listener: _start_resource_monitoring 18:22:03 INFO - Starting resource monitoring. 18:22:03 INFO - [mozharness: 2016-09-02 01:22:03.578120Z] Finished create-virtualenv step (success) 18:22:03 INFO - [mozharness: 2016-09-02 01:22:03.578588Z] Running install step. 18:22:03 INFO - Running pre-action listener: _resource_record_pre_action 18:22:03 INFO - Running main action method: install 18:22:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:22:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:22:03 INFO - Reading from file tmpfile_stdout 18:22:03 INFO - Detecting whether we're running mozinstall >=1.0... 18:22:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:22:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:22:03 INFO - Reading from file tmpfile_stdout 18:22:03 INFO - Output received: 18:22:03 INFO - Usage: mozinstall [options] installer 18:22:03 INFO - Options: 18:22:03 INFO - -h, --help show this help message and exit 18:22:03 INFO - -d DEST, --destination=DEST 18:22:03 INFO - Directory to install application into. [default: 18:22:03 INFO - "/builds/slave/test"] 18:22:03 INFO - --app=APP Application being installed. [default: firefox] 18:22:03 INFO - mkdir: /builds/slave/test/build/application 18:22:03 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'] 18:22:03 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 18:22:20 INFO - Reading from file tmpfile_stdout 18:22:20 INFO - Output received: 18:22:20 INFO - /builds/slave/test/build/application/firefox/firefox 18:22:20 INFO - Running post-action listener: _resource_record_post_action 18:22:20 INFO - [mozharness: 2016-09-02 01:22:20.042515Z] Finished install step (success) 18:22:20 INFO - [mozharness: 2016-09-02 01:22:20.042792Z] Running run-tests step. 18:22:20 INFO - Running pre-action listener: _resource_record_pre_action 18:22:20 INFO - Running main action method: run_tests 18:22:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:22:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:22:20 INFO - Python 2.7.3 18:22:20 INFO - Return code: 0 18:22:20 INFO - grabbing minidump binary from tooltool 18:22:20 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')]} 18:22:20 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 0x25e5d20>, '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 0x25e6c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e70b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:22:20 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 18:22:20 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 18:22:20 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 18:22:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:22:20 INFO - Return code: 0 18:22:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:22:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:22:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:22:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:22:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:22:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bsVgSYJRQNq2IAukgZ7Clw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 18:22:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bsVgSYJRQNq2IAukgZ7Clw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --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 18:22:20 INFO - Using env: {'DISPLAY': ':0', 18:22:20 INFO - 'HOME': '/home/cltbld', 18:22:20 INFO - 'LANG': 'en_US.UTF-8', 18:22:20 INFO - 'LANGUAGE': 'en_US:en', 18:22:20 INFO - 'LOGNAME': 'cltbld', 18:22:20 INFO - 'MAIL': '/var/mail/cltbld', 18:22:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:22:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:22:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:22:20 INFO - 'MOZ_NO_REMOTE': '1', 18:22:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:22:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:22:20 INFO - 'NO_EM_RESTART': '1', 18:22:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:22:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:22:20 INFO - 'PWD': '/builds/slave/test', 18:22:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:22:20 INFO - 'SHELL': '/bin/bash', 18:22:20 INFO - 'SHLVL': '1', 18:22:20 INFO - 'TERM': 'linux', 18:22:20 INFO - 'TMOUT': '86400', 18:22:20 INFO - 'USER': 'cltbld', 18:22:20 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1472775031.950260-588082060', 18:22:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:22:20 INFO - '_': '/tools/buildbot/bin/python'} 18:22:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bsVgSYJRQNq2IAukgZ7Clw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 18:22:20 INFO - mozversion application_buildid: 20160901170142 18:22:20 INFO - mozversion application_changeset: 4bee815089891447e819466885b771bf1db1f59a 18:22:20 INFO - mozversion application_display_name: Nightly 18:22:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:22:20 INFO - mozversion application_name: Firefox 18:22:20 INFO - mozversion application_remotingname: firefox 18:22:20 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:22:20 INFO - mozversion application_vendor: Mozilla 18:22:20 INFO - mozversion application_version: 51.0a1 18:22:20 INFO - mozversion platform_buildid: 20160901170142 18:22:20 INFO - mozversion platform_changeset: 4bee815089891447e819466885b771bf1db1f59a 18:22:20 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:22:20 INFO - mozversion platform_version: 51.0a1 18:22:20 INFO - using testdate: 1472779340 18:22:20 INFO - actual date: 1472779340 18:22:20 INFO - starting webserver on 'localhost:43625' 18:22:20 INFO - SUITE-START | Running 2 tests 18:22:20 INFO - TEST-START | dromaeo_css 18:22:20 INFO - operating with platform_type : linux_ 18:22:20 INFO - Initialising browser for dromaeo_css test... 18:22:20 INFO - TEST-INFO | started process 12688 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbKUVym/profile http://localhost:43625/getInfo.html) 18:22:25 INFO - PROCESS | 12688 | __metrics Screen width/height:1600/1200 18:22:25 INFO - PROCESS | 12688 | colorDepth:24 18:22:25 INFO - PROCESS | 12688 | Browser inner width/height: 1024/697 18:22:25 INFO - PROCESS | 12688 | __metrics 18:22:25 INFO - PROCESS | 12688 | 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" 18:22:25 INFO - PROCESS | 12688 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:22:26 INFO - PROCESS | 12688 | console.error: PushService: 18:22:26 INFO - PROCESS | 12688 | stateChangeProcessEnqueue: Error transitioning state 18:22:26 INFO - PROCESS | 12688 | UnknownError 18:22:27 INFO - TEST-INFO | 12688: exit 0 18:22:27 INFO - Browser initialized. 18:22:27 INFO - Running cycle 1/1 for dromaeo_css test... 18:22:27 INFO - TEST-INFO | started process 12769 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbKUVym/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:22:39 INFO - PROCESS | 12769 | RSS: Main: 181604352 18:22:39 INFO - PROCESS | 12769 | 18:23:30 INFO - PROCESS | 12769 | 1472779410511 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] 18:25:44 INFO - PROCESS | 12769 | Cycle 1(1): loaded http://localhost:43625/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43625/tests/dromaeo/cssquery-ext.html) 18:25:45 INFO - PROCESS | 12769 | RSS: Main: 256679936 18:25:45 INFO - PROCESS | 12769 | 18:28:47 INFO - PROCESS | 12769 | Cycle 1(1): loaded http://localhost:43625/tests/dromaeo/cssquery-ext.html (next: http://localhost:43625/tests/dromaeo/cssquery-jquery.html) 18:28:48 INFO - PROCESS | 12769 | RSS: Main: 265900032 18:28:48 INFO - PROCESS | 12769 | 18:31:50 INFO - PROCESS | 12769 | Cycle 1(1): loaded http://localhost:43625/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43625/tests/dromaeo/cssquery-mootools.html) 18:31:51 INFO - PROCESS | 12769 | RSS: Main: 257056768 18:31:51 INFO - PROCESS | 12769 | 18:34:53 INFO - PROCESS | 12769 | Cycle 1(1): loaded http://localhost:43625/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43625/tests/dromaeo/cssquery-prototype.html) 18:34:54 INFO - PROCESS | 12769 | RSS: Main: 219611136 18:34:54 INFO - PROCESS | 12769 | 18:37:57 INFO - PROCESS | 12769 | Cycle 1(1): loaded http://localhost:43625/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43625/tests/dromaeo/cssquery-yui.html) 18:37:57 INFO - PROCESS | 12769 | RSS: Main: 215007232 18:37:57 INFO - PROCESS | 12769 | 18:41:01 INFO - PROCESS | 12769 | Cycle 1(1): loaded http://localhost:43625/tests/dromaeo/cssquery-yui.html (next: http://localhost:43625/tests/dromaeo/cssquery-dojo.html) 18:41:01 INFO - PROCESS | 12769 | RSS: Main: 305995776 18:41:01 INFO - PROCESS | 12769 | 18:41:01 INFO - PROCESS | 12769 | __start_tp_report 18:41:01 INFO - PROCESS | 12769 | _x_x_mozilla_page_load 18:41:01 INFO - PROCESS | 12769 | _x_x_mozilla_page_load_details 18:41:01 INFO - PROCESS | 12769 | |i|pagename|runs| 18:41:01 INFO - PROCESS | 12769 | |0;dojo.html;2620.489004644094;2656.2296933889165;2657.89368425263;2702.7432393922572;2711.9830063726104;4666.043461090469;4739.265413860849;4780.713157210565;4867.367242258501;4916.606671466283;4741.834035808747;4760.761961901909;4773.856784296468;4780.139574876521;4842.080004799086;4434.179676759793;4465.776711164437;4494.752788596626;4509.143262780078;4523.570260825217;4508.098380323932;4517.683762136652;4524.705894116888;4542.704724192933;4592.265237561991;4445.422095127645;4533.727976321431;4556.088782243564;4556.339330797049;4561.908761824761;4282.42187304713;4326.870193894157;4469.620082293009;4488.6409087273105;4516.209663308908;4346.826126954918;4360.585744354281;4364.258076127066;4367.890802729926;4398.978005109954;4702.576768090888;4723.692959957626;4783;4784.928226076577;4841.128596852565;4920.630952678528;5098.872528186788;5131.4098878629065;5147.124988751922;5211.166213405875;5114.820981265638;5189.04002759487;5215.687058776485;5232.738363081869;5238.5023422774775;4806.327114204014;4844.176489996744;4850.6362022848425;4852.223644216979;4855.854324370274;5167.199084141964;5211.374635043743;5343.438938911436;5345.973270133624;5401.513863752281;5042.596592272609;5043.218301163325;5062.645614807002;5122.590192784568;5123.308353372322;5139.7687104080405;5144.331236939174;5145.331106956147;5152.124138896396;5214.0614689355525;4896.46138924718;4932.210846264652;5100.56645185156;5106.617003724736;5111.948880511221;5055.3428054353435;5067.949320506747;5137.332146820964;5180;5196.558292545176;4352.086061927031;4355.06366131277;4357.629601483846;4402.053558484941;4405.449318835145;3803.220339830328;3836.616338366197;3862.787546684903;3866.149447121629;3867.7679339239735;4356.150550642595;4380.6933514653665;4452.844150454718;4483.30508771141;4493.370928070073;5203.19350500673;5204.21936709489;5204.297419848272;5206.505381988705;5248.685078895279;4453.844115455943;4490.236659767847;4490.910181796346;4533.750643714628;4537.727736335764;4518.118966801442;4575.267957126844;4611.400517932714;4622.329762184531;4641.327007583882;4822.107910036654;4839.564439200489;4842;4886.902261954812;4903.5586797188425;5121.180611102206;5140.100482415637;5149.253358263106;5153.0466863630345;5157.484251574812;4733.266343716729;4787.593054590398;4795.64032697556;4841.733704646278;4886.364772579542;5033.0688822567945;5051.848444546669;5091;5151.381834179922;5151.5106064923775;5139.974300128625;5146.588272938081;5147.124988751846;5147.305113809588;5196.896062078662;4999.350084489139;5015.17249653803;5022.773975171053;5025.296458495886;5086.237064440364;4865.781039853286;4905.313256144214;4940.036692844861;4949.727764972961;5005.199168133081;4859.757012149307;4861.635377346784;4862.07620552094;4875.512448755097;4926.211806111005;4929.926051109164;4930.704157750546;5002.974985125196;5010.724410157331;5020.723860187579;4794.352762377034;4961.280614310833;4964.180910149929;4966.826161084345;5017.899642007066 18:41:01 INFO - PROCESS | 12769 | |1;ext.html;524.769101595298;558.9496945274924;561.1554610311481;573.9339975902769;579.8869220502002;30000.249993750167;37828.243435131284;38795;38941.41587876177;43683.78158109205;40079;40477.797611011905;40565.39151912724;40648.59351406485;40651.186976260455;7161.534500257467;7538.246175382459;7657.617119144048;7710.922890771105;7731.8067048323965;9412.247020238365;9713.32006759527;9720.562574684156;9995.2003839693;10003.199744020461;9771.804563908718;9871.160951319147;9875.555599998017;9882.752931176707;9892.060254275832;9862.260330475207;9922.950385248028;9924.40453572788;9925.801483970352;9928.156106730936;9789.951050244703;9857.55640996157;9858.211343092535;9859.753506162331;9867.60529578816;37489.81255093707;37755.433668494996;37767.24465510702;37799.43300850489;37863.432048519295;2913.6212292402065;2958.5118455454826;2964.7628189744983;3033.605631267943;3241.594800649919;27990.720092799016;28187.29531761702;28531.144065677854;28843.56734648982;29094.27264318409;3382.408078586262;3524.506569080331;3566.7503274770775;3575.8748443804343;3703.8333275002688;245626;246952;247995;248291;249109;51278.53904105781;51588.74205628948;51615.7419212909;51657;51711.48288517067;31715.20711982219;32800.50799238013;32878.17804554857;34881;54948;14561.490347837775;15050.698986020438;15057.247137643293;15058.397664093533;15061.322240499203;10450.11174050199;10737.087347575387;11275.54897804095;11345.659630211107;11348.14888883337;15531.5340539784;17044.14779261057;17727;17798.110094495223;18223.362182323555;6639.834004149935;6726.831829204309;6730.125083739181;6814.659267036628;6829.760958366433;788.6727008291609;854.747849384433;873;912.7261821453537;943.9811203775886;27499.725002750118;28210.576841347396;28249.43501130007;28589.428211435654;28689.282767930552;908.6774195160755;941.6751220828803;946.5078159357096;954.5704433005176;1047.7537778622018;14758.040727352687;14917.254137293092;14976.475823346349;15134.318955647022;15241;388840;392238;392918;393011;393456;33370.33259334848;33573.83213083919;33747.66252337445;50052.499475004784;50123;1025.29254814178;1053.262716098734;1149.5689116581282;1149.7010777197822;1163.2555164694602;25410.364740881625;28693;28959.42081158407;29534.261643459085;29656.851715741283;40602.79698601488;41174.58825411827;41179.38230926599;41201.587984120975;41296;307222;307812;308968;309186;309397;24462.87768561217;25221.369465762768;25551;25633;26582.86708566445;40862;41132.58867411407;41337.79331103325;41597.79201104096;42547.787261063495;34957.65042349544;35023;35439.29121417506;35599.28801423905;35820.462693060144;33716.66283337135;33979.4903076459;34015.319693606485;34021;34037.319253615286;34729.47905781466;34980.65019349876;35671.28657426889;35751.10622234465;35857;30402.239944001576;33291.334173316885;33862.492062619574;35640.643593563735;36258.4561231587;24824.25527234186;25153;25220.621690675023;25488.617670735326;25883 18:41:01 INFO - PROCESS | 12769 | |2;jquery.html;349.9667531584499;354.65775526616795;369.75780863534385;370.7238107609831;389.27206124547104;12352;15671.608209794747;16086.75869861953;16126.596835079128;17231.569210769736;15908.681826363465;16240.187990600452;17260.654786904255;17425.30298788047;17571.91214043931;5043.546080852713;5089.618278629099;5168.483151684839;5191.506806853343;5203.531682148606;3646.270745850827;5097.209932460456;5176.301199338098;5177.068127737006;5178.249153872686;5627.577931655122;5906.763729450817;5938.584299099065;6050.878982420349;6063.636181829104;5831.708414579297;6016.037434010559;6025.126356678301;6086.786962456337;6117.357677443893;5379.946200537984;5392.595555333326;5392.676439413609;5395.136778115482;5400.78396864125;19969.500762480908;20520.486987825276;20634.690479642817;20648.277310294066;20669.793302066937;1754.4473490850469;1802.2160360243336;1838.273881816675;2060.2377120465526;2249.7975182233513;12446.688832779162;13194.67013324665;13476.191428514321;13558.93220533891;13925.025248232629;1743.232977489913;1756.710142826432;1781.1806568978157;1785.589314457669;1846.1046392499627;66078.3392166077;68359;68433;68904.31095689029;71550.28449715437;9500.809983800285;9749.951250243703;9807.950960245153;10040.598376064876;10122;13295.933520332337;13321.866781332257;13377.063605547519;13402.731945361038;13406.798898016537;7472.14070381913;7476.775696729107;7576.090869095744;7660.578668173192;7749.573773442402;6731.730730770812;6772.627505487147;7081.504294699322;7150.678219480136;7387.741429049957;6017.729202185912;6126.142340072393;6183.258009038944;6264.37356264379;6337.8732425352155;1712.4520153550993;1722.7415887616958;1745.3891138101817;1763.576741582011;1780.7150855863;769.6151924037981;830.7175560309523;865.6364326982557;917.4220241247971;955.9713208603753;16249.837501625068;16870;17320.480385588453;17322.913385432992;18141.27434902589;817.5421763812166;820.0487434575863;839.2237180607913;856.486108334994;886.3529623374973;6847.417969472651;9745.122938935388;9775.31572789912;10003.949980250052;10030.398176109456;401976;412560;422548;423839;424091;82215;84200.57899710462;85254.57372713096;85453.57273213594;86904;886.9157430044136;902.4540153207215;938.024454567256;939.8543225799875;941.7221919533754;15556.766648500508;15650.608734781721;16287.51137465878;16462.506124816275;16705.415310464563;37355.43966840554;38752.22495550017;38878;39108.41337379999;39332.80333598314;48303.75848120737;52494.95010099853;53426.8629254841;53507;55934;6613.173353330833;6878.27778083314;6902.792916212522;7172.677229524579;7550;7281.672324745293;7292.890606640798;9194.724158275263;9760.951195243979;12025.75948481008;10078.647247346307;10250.128739057263;10432.739181520523;10901.201301785117;10964.835527467254;5885.293764748258;6088.604240724516;10365.896341036492;10436.217283703601;10486.318389304672;10233.846492302473;10431.94784026075;10601.575936962436;10618.946905265424;10905.618303359344;7006.334398232159;7213.87190778711;7265.636718164176;7324.450666200163;7670.27132422419;8860.29117670572;10460.738481538023;10471.94764026175;10591.311564748266;11078 18:41:01 INFO - PROCESS | 12769 | |3;mootools.html;1202.6933132051327;1317.295247042832;1362.7410791949533;1409.3869166912393;1656.0643236571336;7326.340629343358;7606.201348858373;7681.923180768197;7875.960620196905;7889.684412623488;7747.845043099134;7869.291763741262;7869.724559640414;7870.212978702127;7875.92124078759;2171.5439757650875;2197.6154173019736;2198.505336299336;2198.857074290166;2199.7360316761933;2135.9359219223447;2170.066871245364;2186.6392045312505;2193.1008286602496;2195.879226642534;2165.436986383536;2189.069645400706;2189.704389907358;2193.451637090727;2204.6252137136726;2044.0597325230412;2046.5190680190144;2050.507878109243;2059.2998380550684;2061.154926480136;2090.2266161520183;2145.1955516681246;2147.903344349508;2152.7954844289766;2154.504463973279;7433.368163706037;7713.884291735629;7763.456558040939;7812;7815.140334563193;4433.756143412111;4624.560666736655;4628.8148474061;4628.976855115703;4633.32816741574;2705.1208357283963;2846.4876322261985;2898.0581311073984;2907.7964542482036;2914.198595386286;923.6166990698852;924.4499522783933;940.5720397219249;940.83535381308;945.3618807305041;10546.050855422973;10558.366498010068;10568;10614.363138211733;10655.200859935536;3879.243547508209;4018.678505719535;4181.60274773896;4191.245575796325;4224.1129362834145;8685.696000640073;8699.695510657224;8710.21608055278;8712.912870871336;8714.52070136136;4483.820647174141;4522.977385113119;4523.5024147343765;4538.387317712132;4558.908821823611;3589.138606734365;4100.7334523255895;4155.4182414462;4161.313383291784;4229.788510574459;3395.8132302723093;3428.879989200366;3528.382533056756;3532.894013179609;3556.1643013891717;1013.4324778124274;1020.5203554329602;1028.0877567724028;1037.222083437422;1060.4644654449453;745.273358475482;752.9924700752922;817.7505860712421;833.8082241084585;845.4842546046906;5137.974310128426;5152.9742351288005;5235.3717553893775;5322.866928326823;5340.973295133499;392.6230818414354;402.57327233132975;409.57608874814423;412.1118988579616;414.4674093789466;3681.5950245472977;3685.8157092145284;3690.5975729222723;3699.72252081095;3793.8292776824555;9684.70945871625;9932.553035113437;10022.448765317831;10140.340877842917;10148.441835699108;9984.15134713543;10040.598376065022;10050.447225402673;10056.944020877849;10066.295359324924;7456.813579660552;7485.737999170003;7512.361449276764;7567.545947243183;7571.621418929031;5231.607629427732;5329.73351332424;5331.3868905076415;5335.519803217574;5346.572274217975;8902;8919.687810926587;8923.286137109146;8977.640894364413;9028.052054534443;8722.869156962524;8941.597628106882;9025.277977761894;9120.133587309196;9140.908590914272;6155.907661384993;6424.229092508929;6681.933180668131;6826.556273842184;6832.521723479507;7580.734674286374;7772.650230739518;7859.449838511478;7860.528368297921;7867.685292588232;6769.323067693192;6844.4524438043845;6853.280405557344;6859.519833611599;7072.893906591303;6752;6752.5948443093575;6771.984202369684;6796.76211332601;6884.070650462324;6388.8083357499345;6468.579542329733;6482.222133344029;6489.772857949949;6491.870162596816;4505.256632655575;4520.6835521514495;4562.087582483583;4565.908681826411;4623.445186577497;4394.538573449741;4444;4449.065696203834;4645.953540464552;4794.5924596409695 18:41:01 INFO - PROCESS | 12769 | |4;prototype.html;297.4170625573875;297.6428286056732;303.99984052467374;306.2160868177466;308.6435167381675;4922.360093187889;4945.738836596667;4955.405351357842;4968.900621987567;5001.574866136379;4533.773311334437;4701.9059618807605;4704.270838020104;4711.340412342275;4830.623272367376;3696.3716168251326;3748.418995055764;3756.3426400379963;3821.9235615287816;3837.57786643469;3819.0141126614144;3831.540215174183;3835.3096442640312;3842.7694338339647;3860;3559.4660800879815;3729.482599245512;3799.9430008549894;3820.083180036785;3825.234953009395;3761;3765.2093060457337;3772.4718539404507;3774.320622288001;3774.792386418746;3303.487959366302;3303.884364047271;3305.4215512285255;3310.702036816698;3314.5193946877566;4721.716696998191;4727.550882666142;4734.455537613149;4746.810127594892;4752.263399173134;4069.654079403225;4310.1379724055005;4311.568843115663;4351.977285337943;4375.409319741826;5076.847694569169;5092.574079257776;5117.641765076446;5119.180931051052;5126.512981266774;3635.0730563706084;3637.6907962823193;3639.399499082648;3647.5075864758182;3676.356637588411;5106.923396149061;5287.23335116406;5314.92027619586;5355.937963883933;5365.731713414314;3691.7046636269033;3702.8703995360033;3704.4258139988347;3713.832877520518;3721.209093180115;3748.7375883688424;3752.6247375262255;3758.548974123068;3759.342115129841;3776.3580191367532;4320.3519472078815;4331.177076355482;4334.1981733379425;4341.978290108529;4350.21696094706;4954.752262386866;5078.009788091286;5089.312942752681;5125.078095714107;5132.2798916574275;1301.6030110816102;1305.2951406240713;1305.8563558008611;1311.672081979505;1313.967150821237;819.8319344534475;923.1184219070772;942.783159873233;955.1613144696431;956.8947415784259;4449.332600109945;4473.261911784584;4478.880279930017;4506.504284528699;4516.432018705252;5171.689698618095;5194.870128246824;5220.7128607926925;5243.501867322599;5249.947500525022;4319.5386669181125;4495.662825288116;4515.638748900145;4528.841490547881;4550.840720574764;2764.972350276512;2768.321761168527;2773.778097752175;2777.666679998413;2780.3466185446405;4862.513748625109;4886.338644860693;4889.877753056202;4890.095332363524;4900.558949694545;5159.716215608102;5230.587741309825;5255.947440525546;5294;5312.814051508179;4838.879028024327;4854.83008094722;4864.878378040577;4866.732329721828;4867.415910090812;5202.869928251824;5204.776877433725;5205.843824685266;5206.869828254324;5216.765245563883;4902.436219834764;5099.14447909172;5144.202648589325;5165.586753059671;5166.509181627739;4945.826896058621;4950.6039516837845;4951.925721114114;4952.678075925053;4954.108260513142;3760.417135344026;3766.6798322142927;3780.5085338905765;3785.5835858056143;3786.5645450773513;5149.536541711264;5267.446918073547;5296.496832801032;5301.363836339664;5356.5982551308025;5123.538881500683;5131.179011358165;5144.871378215575;5152.819651312186;5164.612654050886;5089.618278629192;5140.43455219933;5158.406783219978;5160;5165.121929272108;4921.972986613278;5033.446320904624;5065.265536497261;5067.341245638044;5075.441701412916;4921.311016457627;4954.142196676246;5127.53852153308;5129.8717532062;5142.76857541404;5012.172991456368;5012.498750124958;5012.899742005213;5022.84931452057;5061.190209566599 18:41:01 INFO - PROCESS | 12769 | |5;yui.html;564.4722184757252;570.2017175953664;570.8601392658799;602.6083046020086;653.8561516466376;12760.744785104303;13279.800802987962;13451.596452106429;13940.860591394083;13944.790828137573;12852.67868303293;13096.47614095435;13109.737805243889;13116.606501804938;13123.6719082023;596.5168213746879;723.8154270660974;741.8516296740646;744.4937442539072;744.7728442824963;718.392957950531;748.0275641665839;750.5196674128562;754.5698951597592;755.962201889906;788.1015642167933;789.743333416639;790.3913986230599;790.8892755014302;790.9920900790976;617.6849806598622;786.5438045933345;788.2747871957813;788.3102285500187;788.6766425765466;549.8377978496313;565.2341077839551;570.2529686111208;570.4324197423549;571.0691572736455;13379.063465557414;13413.128146670435;13416.798748018788;13420.328983550784;13432;11576.247543909703;11888.940555297255;12162.209456385395;12217.93891030548;12309.384530773426;9279.860802087975;9726.416415015052;11154.944225278903;11250.437478126143;11373.886261137366;3954.169624378884;3986.4219688145345;3989.98005009976;3992.7803970781597;4178.080822219107;62226.37773622297;62256.377436225965;62569.37430625681;63019.6849015752;63484.682576587285;9183.449432147025;9254.444733316022;9376.531173441437;9401.71794846142;9428.669996550088;16772;16779.83220167807;16786.916065419595;16794.412195573095;16980.91509542469;6210.875782484325;6310.1796766420075;6313.179286692793;6437.0988061671405;6485.286618471964;3473.235888104613;3496.982515087459;3503.4219353806848;3509.94735078974;3545.0782796473104;2785.818921770119;2909.38902830408;2915.5772413000423;2916.1105862712075;2918.1099764571586;499.57785671107854;509.3760143823786;511.524282417348;512.1984094891483;517.8575891629832;467.6422536759382;506.37209859773617;539.4389834572002;541.4828838459262;544.4609836262072;6932.847376780625;7255.419566434673;7458.925410745932;7507.324340809353;7695.268949449905;449.22060225508716;506.16735470151394;530.191458026505;531.9867003324948;540.1708377640304;3428.8114153721285;3460.1003739028033;3550.6449355064287;3571.7678350907627;3616.620254873253;97905;101766.49116754517;103905;104659.47670261753;104714.47642761738;51942.48057519377;52522.73738631359;85713.28576928204;87966.56016719875;91291;80077;80383;80411;80860;81566;6603.471722262304;6662.633555154319;6788.4569234462115;6823.795286141423;6871.209810871814;32253.677463225067;46364.768176158905;46691.533084670074;47290.29064563965;48392.27411588899;38568.80715596404;39788.602113978486;65252.800983906454;67201.66399167973;67744.66127669527;8945.19493245611;9132.589033493641;9272.165505104573;10336.276460647983;10511.632092876713;12019.879801202225;12305.876941230474;12486.12597118193;13264.071514993857;13368.933155334551;11743.236689615147;11775.941120294343;12277.26336419782;12570.748585028432;12678;11622.6513204604;11706.180567360203;12001.099917506048;12261.509539618315;12636.178648387826;10824.4046577439;11450.541978321107;11485.540578376771;11522.193446458667;11656.53373865036;9338.206252468617;9664.806703866025;9751;9799.804003920024;10198.847017294895;9216.493092879688;9285.953570232376;9350.812983740423;9375.906240937504;9446.527673616429 18:41:01 INFO - PROCESS | 12769 | __end_tp_report 18:41:01 INFO - PROCESS | 12769 | __start_cc_report 18:41:01 INFO - PROCESS | 12769 | _x_x_mozilla_cycle_collect,804 18:41:01 INFO - PROCESS | 12769 | __end_cc_report 18:41:01 INFO - PROCESS | 12769 | __startTimestamp1472780461422__endTimestamp 18:41:01 INFO - PROCESS | 12769 | 18:41:01 INFO - PROCESS | 12769 | ------- Summary: start ------- 18:41:01 INFO - PROCESS | 12769 | Number of tests: 6 18:41:01 INFO - PROCESS | 12769 | 18:41:01 INFO - PROCESS | 12769 | [#0] dojo.html Cycles:165 Average:4756.54 Median:4861.64 stddev:493.50 (10.2%) stddev-sans-first:465.69 18:41:01 INFO - PROCESS | 12769 | Values: 2620.5 2656.2 2657.9 2702.7 2712.0 4666.0 4739.3 4780.7 4867.4 4916.6 4741.8 4760.8 4773.9 4780.1 4842.1 4434.2 4465.8 4494.8 4509.1 4523.6 4508.1 4517.7 4524.7 4542.7 4592.3 4445.4 4533.7 4556.1 4556.3 4561.9 4282.4 4326.9 4469.6 4488.6 4516.2 4346.8 4360.6 4364.3 4367.9 4399.0 4702.6 4723.7 4783.0 4784.9 4841.1 4920.6 5098.9 5131.4 5147.1 5211.2 5114.8 5189.0 5215.7 5232.7 5238.5 4806.3 4844.2 4850.6 4852.2 4855.9 5167.2 5211.4 5343.4 5346.0 5401.5 5042.6 5043.2 5062.6 5122.6 5123.3 5139.8 5144.3 5145.3 5152.1 5214.1 4896.5 4932.2 5100.6 5106.6 5111.9 5055.3 5067.9 5137.3 5180.0 5196.6 4352.1 4355.1 4357.6 4402.1 4405.4 3803.2 3836.6 3862.8 3866.1 3867.8 4356.2 4380.7 4452.8 4483.3 4493.4 5203.2 5204.2 5204.3 5206.5 5248.7 4453.8 4490.2 4490.9 4533.8 4537.7 4518.1 4575.3 4611.4 4622.3 4641.3 4822.1 4839.6 4842.0 4886.9 4903.6 5121.2 5140.1 5149.3 5153.0 5157.5 4733.3 4787.6 4795.6 4841.7 4886.4 5033.1 5051.8 5091.0 5151.4 5151.5 5140.0 5146.6 5147.1 5147.3 5196.9 4999.4 5015.2 5022.8 5025.3 5086.2 4865.8 4905.3 4940.0 4949.7 5005.2 4859.8 4861.6 4862.1 4875.5 4926.2 4929.9 4930.7 5003.0 5010.7 5020.7 4794.4 4961.3 4964.2 4966.8 5017.9 18:41:01 INFO - PROCESS | 12769 | 18:41:01 INFO - PROCESS | 12769 | [#1] ext.html Cycles:180 Average:46464.48 Median:35619.97 stddev:84589.12 (237.5%) stddev-sans-first:84756.09 18:41:01 INFO - PROCESS | 12769 | Values: 524.8 558.9 561.2 573.9 579.9 30000.2 37828.2 38795.0 38941.4 43683.8 40079.0 40477.8 40565.4 40648.6 40651.2 7161.5 7538.2 7657.6 7710.9 7731.8 9412.2 9713.3 9720.6 9995.2 10003.2 9771.8 9871.2 9875.6 9882.8 9892.1 9862.3 9923.0 9924.4 9925.8 9928.2 9790.0 9857.6 9858.2 9859.8 9867.6 37489.8 37755.4 37767.2 37799.4 37863.4 2913.6 2958.5 2964.8 3033.6 3241.6 27990.7 28187.3 28531.1 28843.6 29094.3 3382.4 3524.5 3566.8 3575.9 3703.8 245626.0 246952.0 247995.0 248291.0 249109.0 51278.5 51588.7 51615.7 51657.0 51711.5 31715.2 32800.5 32878.2 34881.0 54948.0 14561.5 15050.7 15057.2 15058.4 15061.3 10450.1 10737.1 11275.5 11345.7 11348.1 15531.5 17044.1 17727.0 17798.1 18223.4 6639.8 6726.8 6730.1 6814.7 6829.8 788.7 854.7 873.0 912.7 944.0 27499.7 28210.6 28249.4 28589.4 28689.3 908.7 941.7 946.5 954.6 1047.8 14758.0 14917.3 14976.5 15134.3 15241.0 388840.0 392238.0 392918.0 393011.0 393456.0 33370.3 33573.8 33747.7 50052.5 50123.0 1025.3 1053.3 1149.6 1149.7 1163.3 25410.4 28693.0 28959.4 29534.3 29656.9 40602.8 41174.6 41179.4 41201.6 41296.0 307222.0 307812.0 308968.0 309186.0 309397.0 24462.9 25221.4 25551.0 25633.0 26582.9 40862.0 41132.6 41337.8 41597.8 42547.8 34957.7 35023.0 35439.3 35599.3 35820.5 33716.7 33979.5 34015.3 34021.0 34037.3 34729.5 34980.7 35671.3 35751.1 35857.0 30402.2 33291.3 33862.5 35640.6 36258.5 24824.3 25153.0 25220.6 25488.6 25883.0 18:41:01 INFO - PROCESS | 12769 | 18:41:01 INFO - PROCESS | 12769 | [#2] jquery.html Cycles:180 Average:25386.69 Median:5093.41 stddev:68892.19 (1352.6%) stddev-sans-first:69059.81 18:41:01 INFO - PROCESS | 12769 | Values: 350.0 354.7 369.8 370.7 389.3 12352.0 15671.6 16086.8 16126.6 17231.6 15908.7 16240.2 17260.7 17425.3 17571.9 5043.5 5089.6 5168.5 5191.5 5203.5 3646.3 5097.2 5176.3 5177.1 5178.2 5627.6 5906.8 5938.6 6050.9 6063.6 5831.7 6016.0 6025.1 6086.8 6117.4 5379.9 5392.6 5392.7 5395.1 5400.8 19969.5 20520.5 20634.7 20648.3 20669.8 1754.4 1802.2 1838.3 2060.2 2249.8 12446.7 13194.7 13476.2 13558.9 13925.0 1743.2 1756.7 1781.2 1785.6 1846.1 66078.3 68359.0 68433.0 68904.3 71550.3 9500.8 9750.0 9808.0 10040.6 10122.0 13295.9 13321.9 13377.1 13402.7 13406.8 7472.1 7476.8 7576.1 7660.6 7749.6 6731.7 6772.6 7081.5 7150.7 7387.7 6017.7 6126.1 6183.3 6264.4 6337.9 1712.5 1722.7 1745.4 1763.6 1780.7 769.6 830.7 865.6 917.4 956.0 16249.8 16870.0 17320.5 17322.9 18141.3 817.5 820.0 839.2 856.5 886.4 6847.4 9745.1 9775.3 10003.9 10030.4 401976.0 412560.0 422548.0 423839.0 424091.0 82215.0 84200.6 85254.6 85453.6 86904.0 886.9 902.5 938.0 939.9 941.7 15556.8 15650.6 16287.5 16462.5 16705.4 37355.4 38752.2 38878.0 39108.4 39332.8 48303.8 52495.0 53426.9 53507.0 55934.0 6613.2 6878.3 6902.8 7172.7 7550.0 7281.7 7292.9 9194.7 9761.0 12025.8 10078.6 10250.1 10432.7 10901.2 10964.8 5885.3 6088.6 10365.9 10436.2 10486.3 10233.8 10431.9 10601.6 10618.9 10905.6 7006.3 7213.9 7265.6 7324.5 7670.3 8860.3 10460.7 10471.9 10591.3 11078.0 18:41:01 INFO - PROCESS | 12769 | 18:41:01 INFO - PROCESS | 12769 | [#3] mootools.html Cycles:180 Average:5133.19 Median:4624.00 stddev:2944.98 (63.7%) stddev-sans-first:2938.42 18:41:01 INFO - PROCESS | 12769 | Values: 1202.7 1317.3 1362.7 1409.4 1656.1 7326.3 7606.2 7681.9 7876.0 7889.7 7747.8 7869.3 7869.7 7870.2 7875.9 2171.5 2197.6 2198.5 2198.9 2199.7 2135.9 2170.1 2186.6 2193.1 2195.9 2165.4 2189.1 2189.7 2193.5 2204.6 2044.1 2046.5 2050.5 2059.3 2061.2 2090.2 2145.2 2147.9 2152.8 2154.5 7433.4 7713.9 7763.5 7812.0 7815.1 4433.8 4624.6 4628.8 4629.0 4633.3 2705.1 2846.5 2898.1 2907.8 2914.2 923.6 924.4 940.6 940.8 945.4 10546.1 10558.4 10568.0 10614.4 10655.2 3879.2 4018.7 4181.6 4191.2 4224.1 8685.7 8699.7 8710.2 8712.9 8714.5 4483.8 4523.0 4523.5 4538.4 4558.9 3589.1 4100.7 4155.4 4161.3 4229.8 3395.8 3428.9 3528.4 3532.9 3556.2 1013.4 1020.5 1028.1 1037.2 1060.5 745.3 753.0 817.8 833.8 845.5 5138.0 5153.0 5235.4 5322.9 5341.0 392.6 402.6 409.6 412.1 414.5 3681.6 3685.8 3690.6 3699.7 3793.8 9684.7 9932.6 10022.4 10140.3 10148.4 9984.2 10040.6 10050.4 10056.9 10066.3 7456.8 7485.7 7512.4 7567.5 7571.6 5231.6 5329.7 5331.4 5335.5 5346.6 8902.0 8919.7 8923.3 8977.6 9028.1 8722.9 8941.6 9025.3 9120.1 9140.9 6155.9 6424.2 6681.9 6826.6 6832.5 7580.7 7772.7 7859.4 7860.5 7867.7 6769.3 6844.5 6853.3 6859.5 7072.9 6752.0 6752.6 6772.0 6796.8 6884.1 6388.8 6468.6 6482.2 6489.8 6491.9 4505.3 4520.7 4562.1 4565.9 4623.4 4394.5 4444.0 4449.1 4646.0 4794.6 18:41:01 INFO - PROCESS | 12769 | 18:41:01 INFO - PROCESS | 12769 | [#4] prototype.html Cycles:180 Average:4228.07 Median:4846.85 stddev:1220.89 (25.2%) stddev-sans-first:1188.13 18:41:01 INFO - PROCESS | 12769 | Values: 297.4 297.6 304.0 306.2 308.6 4922.4 4945.7 4955.4 4968.9 5001.6 4533.8 4701.9 4704.3 4711.3 4830.6 3696.4 3748.4 3756.3 3821.9 3837.6 3819.0 3831.5 3835.3 3842.8 3860.0 3559.5 3729.5 3799.9 3820.1 3825.2 3761.0 3765.2 3772.5 3774.3 3774.8 3303.5 3303.9 3305.4 3310.7 3314.5 4721.7 4727.6 4734.5 4746.8 4752.3 4069.7 4310.1 4311.6 4352.0 4375.4 5076.8 5092.6 5117.6 5119.2 5126.5 3635.1 3637.7 3639.4 3647.5 3676.4 5106.9 5287.2 5314.9 5355.9 5365.7 3691.7 3702.9 3704.4 3713.8 3721.2 3748.7 3752.6 3758.5 3759.3 3776.4 4320.4 4331.2 4334.2 4342.0 4350.2 4954.8 5078.0 5089.3 5125.1 5132.3 1301.6 1305.3 1305.9 1311.7 1314.0 819.8 923.1 942.8 955.2 956.9 4449.3 4473.3 4478.9 4506.5 4516.4 5171.7 5194.9 5220.7 5243.5 5249.9 4319.5 4495.7 4515.6 4528.8 4550.8 2765.0 2768.3 2773.8 2777.7 2780.3 4862.5 4886.3 4889.9 4890.1 4900.6 5159.7 5230.6 5255.9 5294.0 5312.8 4838.9 4854.8 4864.9 4866.7 4867.4 5202.9 5204.8 5205.8 5206.9 5216.8 4902.4 5099.1 5144.2 5165.6 5166.5 4945.8 4950.6 4951.9 4952.7 4954.1 3760.4 3766.7 3780.5 3785.6 3786.6 5149.5 5267.4 5296.5 5301.4 5356.6 5123.5 5131.2 5144.9 5152.8 5164.6 5089.6 5140.4 5158.4 5160.0 5165.1 4922.0 5033.4 5065.3 5067.3 5075.4 4921.3 4954.1 5127.5 5129.9 5142.8 5012.2 5012.5 5012.9 5022.8 5061.2 18:41:01 INFO - PROCESS | 12769 | 18:41:01 INFO - PROCESS | 12769 | [#5] yui.html Cycles:180 Average:17378.13 Median:26230.17 stddev:25546.46 (97.4%) stddev-sans-first:25586.93 18:41:01 INFO - PROCESS | 12769 | Values: 564.5 570.2 570.9 602.6 653.9 12760.7 13279.8 13451.6 13940.9 13944.8 12852.7 13096.5 13109.7 13116.6 13123.7 596.5 723.8 741.9 744.5 744.8 718.4 748.0 750.5 754.6 756.0 788.1 789.7 790.4 790.9 791.0 617.7 786.5 788.3 788.3 788.7 549.8 565.2 570.3 570.4 571.1 13379.1 13413.1 13416.8 13420.3 13432.0 11576.2 11888.9 12162.2 12217.9 12309.4 9279.9 9726.4 11154.9 11250.4 11373.9 3954.2 3986.4 3990.0 3992.8 4178.1 62226.4 62256.4 62569.4 63019.7 63484.7 9183.4 9254.4 9376.5 9401.7 9428.7 16772.0 16779.8 16786.9 16794.4 16980.9 6210.9 6310.2 6313.2 6437.1 6485.3 3473.2 3497.0 3503.4 3509.9 3545.1 2785.8 2909.4 2915.6 2916.1 2918.1 499.6 509.4 511.5 512.2 517.9 467.6 506.4 539.4 541.5 544.5 6932.8 7255.4 7458.9 7507.3 7695.3 449.2 506.2 530.2 532.0 540.2 3428.8 3460.1 3550.6 3571.8 3616.6 97905.0 101766.5 103905.0 104659.5 104714.5 51942.5 52522.7 85713.3 87966.6 91291.0 80077.0 80383.0 80411.0 80860.0 81566.0 6603.5 6662.6 6788.5 6823.8 6871.2 32253.7 46364.8 46691.5 47290.3 48392.3 38568.8 39788.6 65252.8 67201.7 67744.7 8945.2 9132.6 9272.2 10336.3 10511.6 12019.9 12305.9 12486.1 13264.1 13368.9 11743.2 11775.9 12277.3 12570.7 12678.0 11622.7 11706.2 12001.1 12261.5 12636.2 10824.4 11450.5 11485.5 11522.2 11656.5 9338.2 9664.8 9751.0 9799.8 10198.8 9216.5 9286.0 9350.8 9375.9 9446.5 18:41:01 INFO - PROCESS | 12769 | -------- Summary: end -------- 18:41:01 INFO - PROCESS | 12769 | 18:41:02 INFO - TEST-INFO | 12769: exit 0 18:41:02 INFO - TEST-OK | dromaeo_css | took 1121991ms 18:41:02 INFO - TEST-START | kraken 18:41:02 INFO - operating with platform_type : linux_ 18:41:02 INFO - Initialising browser for kraken test... 18:41:02 INFO - TEST-INFO | started process 13071 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpunv6cz/profile http://localhost:43625/getInfo.html) 18:41:07 INFO - PROCESS | 13071 | __metrics Screen width/height:1600/1200 18:41:07 INFO - PROCESS | 13071 | colorDepth:24 18:41:07 INFO - PROCESS | 13071 | Browser inner width/height: 1024/697 18:41:07 INFO - PROCESS | 13071 | __metrics 18:41:07 INFO - PROCESS | 13071 | 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" 18:41:07 INFO - PROCESS | 13071 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:41:08 INFO - PROCESS | 13071 | console.error: PushService: 18:41:08 INFO - PROCESS | 13071 | stateChangeProcessEnqueue: Error transitioning state 18:41:08 INFO - PROCESS | 13071 | UnknownError 18:41:08 INFO - TEST-INFO | 13071: exit 0 18:41:08 INFO - Browser initialized. 18:41:08 INFO - Running cycle 1/1 for kraken test... 18:41:08 INFO - TEST-INFO | started process 13150 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpunv6cz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:41:21 INFO - PROCESS | 13150 | RSS: Main: 180465664 18:41:21 INFO - PROCESS | 13150 | 18:41:23 INFO - PROCESS | 13150 | Cycle 1(1): loaded http://localhost:43625/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43625/tests/kraken/driver.html?testName=audio-beat-detection) 18:41:24 INFO - PROCESS | 13150 | RSS: Main: 235163648 18:41:24 INFO - PROCESS | 13150 | 18:41:27 INFO - PROCESS | 13150 | Cycle 1(1): loaded http://localhost:43625/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43625/tests/kraken/driver.html?testName=audio-dft) 18:41:28 INFO - PROCESS | 13150 | RSS: Main: 225427456 18:41:28 INFO - PROCESS | 13150 | 18:41:31 INFO - PROCESS | 13150 | Cycle 1(1): loaded http://localhost:43625/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43625/tests/kraken/driver.html?testName=audio-fft) 18:41:32 INFO - PROCESS | 13150 | RSS: Main: 302243840 18:41:32 INFO - PROCESS | 13150 | 18:41:34 INFO - PROCESS | 13150 | Cycle 1(1): loaded http://localhost:43625/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43625/tests/kraken/driver.html?testName=audio-oscillator) 18:41:34 INFO - PROCESS | 13150 | RSS: Main: 211460096 18:41:34 INFO - PROCESS | 13150 | 18:41:37 INFO - PROCESS | 13150 | Cycle 1(1): loaded http://localhost:43625/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43625/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:41:37 INFO - PROCESS | 13150 | RSS: Main: 214945792 18:41:37 INFO - PROCESS | 13150 | 18:41:40 INFO - PROCESS | 13150 | Cycle 1(1): loaded http://localhost:43625/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43625/tests/kraken/driver.html?testName=imaging-darkroom) 18:41:41 INFO - PROCESS | 13150 | RSS: Main: 253460480 18:41:41 INFO - PROCESS | 13150 | 18:41:44 INFO - PROCESS | 13150 | Cycle 1(1): loaded http://localhost:43625/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43625/tests/kraken/driver.html?testName=imaging-desaturate) 18:41:45 INFO - PROCESS | 13150 | RSS: Main: 252456960 18:41:45 INFO - PROCESS | 13150 | 18:41:48 INFO - PROCESS | 13150 | Cycle 1(1): loaded http://localhost:43625/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43625/tests/kraken/driver.html?testName=json-parse-financial) 18:41:49 INFO - PROCESS | 13150 | RSS: Main: 253145088 18:41:49 INFO - PROCESS | 13150 | 18:41:50 INFO - PROCESS | 13150 | Cycle 1(1): loaded http://localhost:43625/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43625/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:41:51 INFO - PROCESS | 13150 | RSS: Main: 215654400 18:41:51 INFO - PROCESS | 13150 | 18:41:53 INFO - PROCESS | 13150 | Cycle 1(1): loaded http://localhost:43625/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43625/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:41:53 INFO - PROCESS | 13150 | RSS: Main: 222666752 18:41:53 INFO - PROCESS | 13150 | 18:41:56 INFO - PROCESS | 13150 | Cycle 1(1): loaded http://localhost:43625/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43625/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:41:56 INFO - PROCESS | 13150 | RSS: Main: 223916032 18:41:56 INFO - PROCESS | 13150 | 18:41:59 INFO - PROCESS | 13150 | Cycle 1(1): loaded http://localhost:43625/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43625/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:42:00 INFO - PROCESS | 13150 | RSS: Main: 225148928 18:42:00 INFO - PROCESS | 13150 | 18:42:03 INFO - PROCESS | 13150 | Cycle 1(1): loaded http://localhost:43625/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43625/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:42:03 INFO - PROCESS | 13150 | RSS: Main: 222502912 18:42:03 INFO - PROCESS | 13150 | 18:42:05 INFO - PROCESS | 13150 | Cycle 1(1): loaded http://localhost:43625/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43625/tests/kraken/driver.html?testName=ai-astar) 18:42:05 INFO - PROCESS | 13150 | RSS: Main: 272429056 18:42:05 INFO - PROCESS | 13150 | 18:42:05 INFO - PROCESS | 13150 | __start_tp_report 18:42:05 INFO - PROCESS | 13150 | _x_x_mozilla_page_load 18:42:05 INFO - PROCESS | 13150 | _x_x_mozilla_page_load_details 18:42:05 INFO - PROCESS | 13150 | |i|pagename|runs| 18:42:05 INFO - PROCESS | 13150 | |0;ai-astar;115;115;119;116;114;114;114;115;115;130 18:42:05 INFO - PROCESS | 13150 | |1;audio-beat-detection;147;124;146;183;123;148;144;126;196;124 18:42:05 INFO - PROCESS | 13150 | |2;audio-dft;162;161;163;164;162;161;161;162;160;160 18:42:05 INFO - PROCESS | 13150 | |3;audio-fft;76;76;76;171;77;76;76;76;160;76 18:42:05 INFO - PROCESS | 13150 | |4;audio-oscillator;83;83;158;84;84;83;137;83;82;141 18:42:05 INFO - PROCESS | 13150 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;118;117 18:42:05 INFO - PROCESS | 13150 | |6;imaging-darkroom;146;146;146;146;146;145;147;146;145;146 18:42:05 INFO - PROCESS | 13150 | |7;imaging-desaturate;95;95;96;95;94;95;96;95;95;96 18:42:05 INFO - PROCESS | 13150 | |8;json-parse-financial;66;65;66;68;65;67;67;66;65;66 18:42:05 INFO - PROCESS | 13150 | |9;json-stringify-tinderbox;65;66;66;67;66;66;67;66;66;67 18:42:05 INFO - PROCESS | 13150 | |10;stanford-crypto-aes;82;82;82;82;90;91;84;81;81;82 18:42:05 INFO - PROCESS | 13150 | |11;stanford-crypto-ccm;145;142;132;139;133;149;133;133;183;133 18:42:05 INFO - PROCESS | 13150 | |12;stanford-crypto-pbkdf2;182;177;173;175;175;172;179;173;171;172 18:42:05 INFO - PROCESS | 13150 | |13;stanford-crypto-sha256-iterative;71;69;71;68;72;69;69;68;67;68 18:42:05 INFO - PROCESS | 13150 | __end_tp_report 18:42:05 INFO - PROCESS | 13150 | __start_cc_report 18:42:05 INFO - PROCESS | 13150 | _x_x_mozilla_cycle_collect,1947 18:42:05 INFO - PROCESS | 13150 | __end_cc_report 18:42:05 INFO - PROCESS | 13150 | __startTimestamp1472780525943__endTimestamp 18:42:05 INFO - PROCESS | 13150 | 18:42:05 INFO - PROCESS | 13150 | ------- Summary: start ------- 18:42:05 INFO - PROCESS | 13150 | Number of tests: 14 18:42:05 INFO - PROCESS | 13150 | 18:42:05 INFO - PROCESS | 13150 | [#0] ai-astar Cycles:10 Average:116.70 Median:115.00 stddev:4.90 (4.3%) stddev-sans-first:5.16 18:42:05 INFO - PROCESS | 13150 | Values: 115.0 115.0 119.0 116.0 114.0 114.0 114.0 115.0 115.0 130.0 18:42:05 INFO - PROCESS | 13150 | 18:42:05 INFO - PROCESS | 13150 | [#1] audio-beat-detection Cycles:10 Average:146.10 Median:146.50 stddev:25.33 (17.3%) stddev-sans-first:26.87 18:42:05 INFO - PROCESS | 13150 | Values: 147.0 124.0 146.0 183.0 123.0 148.0 144.0 126.0 196.0 124.0 18:42:05 INFO - PROCESS | 13150 | 18:42:05 INFO - PROCESS | 13150 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.26 (0.8%) stddev-sans-first:1.33 18:42:05 INFO - PROCESS | 13150 | Values: 162.0 161.0 163.0 164.0 162.0 161.0 161.0 162.0 160.0 160.0 18:42:05 INFO - PROCESS | 13150 | 18:42:05 INFO - PROCESS | 13150 | [#3] audio-fft Cycles:10 Average:94.00 Median:76.00 stddev:37.77 (49.7%) stddev-sans-first:39.50 18:42:05 INFO - PROCESS | 13150 | Values: 76.0 76.0 76.0 171.0 77.0 76.0 76.0 76.0 160.0 76.0 18:42:05 INFO - PROCESS | 13150 | 18:42:05 INFO - PROCESS | 13150 | [#4] audio-oscillator Cycles:10 Average:101.80 Median:83.00 stddev:30.50 (36.7%) stddev-sans-first:31.58 18:42:05 INFO - PROCESS | 13150 | Values: 83.0 83.0 158.0 84.0 84.0 83.0 137.0 83.0 82.0 141.0 18:42:05 INFO - PROCESS | 13150 | 18:42:05 INFO - PROCESS | 13150 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 18:42:05 INFO - PROCESS | 13150 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 18:42:05 INFO - PROCESS | 13150 | 18:42:05 INFO - PROCESS | 13150 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 18:42:05 INFO - PROCESS | 13150 | Values: 146.0 146.0 146.0 146.0 146.0 145.0 147.0 146.0 145.0 146.0 18:42:05 INFO - PROCESS | 13150 | 18:42:05 INFO - PROCESS | 13150 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 18:42:05 INFO - PROCESS | 13150 | Values: 95.0 95.0 96.0 95.0 94.0 95.0 96.0 95.0 95.0 96.0 18:42:05 INFO - PROCESS | 13150 | 18:42:05 INFO - PROCESS | 13150 | [#8] json-parse-financial Cycles:10 Average:66.10 Median:66.00 stddev:0.99 (1.5%) stddev-sans-first:1.05 18:42:05 INFO - PROCESS | 13150 | Values: 66.0 65.0 66.0 68.0 65.0 67.0 67.0 66.0 65.0 66.0 18:42:05 INFO - PROCESS | 13150 | 18:42:05 INFO - PROCESS | 13150 | [#9] json-stringify-tinderbox Cycles:10 Average:66.20 Median:66.00 stddev:0.63 (1.0%) stddev-sans-first:0.50 18:42:05 INFO - PROCESS | 13150 | Values: 65.0 66.0 66.0 67.0 66.0 66.0 67.0 66.0 66.0 67.0 18:42:05 INFO - PROCESS | 13150 | 18:42:05 INFO - PROCESS | 13150 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:82.00 stddev:3.68 (4.5%) stddev-sans-first:3.86 18:42:05 INFO - PROCESS | 13150 | Values: 82.0 82.0 82.0 82.0 90.0 91.0 84.0 81.0 81.0 82.0 18:42:05 INFO - PROCESS | 13150 | 18:42:05 INFO - PROCESS | 13150 | [#11] stanford-crypto-ccm Cycles:10 Average:142.20 Median:140.50 stddev:15.53 (11.1%) stddev-sans-first:16.44 18:42:05 INFO - PROCESS | 13150 | Values: 145.0 142.0 132.0 139.0 133.0 149.0 133.0 133.0 183.0 133.0 18:42:05 INFO - PROCESS | 13150 | 18:42:05 INFO - PROCESS | 13150 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.90 Median:175.00 stddev:3.51 (2.0%) stddev-sans-first:2.62 18:42:05 INFO - PROCESS | 13150 | Values: 182.0 177.0 173.0 175.0 175.0 172.0 179.0 173.0 171.0 172.0 18:42:05 INFO - PROCESS | 13150 | 18:42:05 INFO - PROCESS | 13150 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:69.00 stddev:1.62 (2.3%) stddev-sans-first:1.58 18:42:05 INFO - PROCESS | 13150 | Values: 71.0 69.0 71.0 68.0 72.0 69.0 69.0 68.0 67.0 68.0 18:42:05 INFO - PROCESS | 13150 | -------- Summary: end -------- 18:42:05 INFO - PROCESS | 13150 | 18:42:07 INFO - TEST-INFO | 13150: exit 0 18:42:07 INFO - TEST-OK | kraken | took 64919ms 18:42:07 INFO - SUITE-END | took 1186s 18:42:07 INFO - Completed test suite (00:19:47) 18:42:07 INFO - javascript benchmark 18:42:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2620.489004644094, 2656.2296933889165, 2657.89368425263, 2702.7432393922572, 2711.9830063726104, 4666.043461090469, 4739.265413860849, 4780.713157210565, 4867.367242258501, 4916.606671466283, 4741.834035808747, 4760.761961901909, 4773.856784296468, 4780.139574876521, 4842.080004799086, 4434.179676759793, 4465.776711164437, 4494.752788596626, 4509.143262780078, 4523.570260825217, 4508.098380323932, 4517.683762136652, 4524.705894116888, 4542.704724192933, 4592.265237561991, 4445.422095127645, 4533.727976321431, 4556.088782243564, 4556.339330797049, 4561.908761824761, 4282.42187304713, 4326.870193894157, 4469.620082293009, 4488.6409087273105, 4516.209663308908, 4346.826126954918, 4360.585744354281, 4364.258076127066, 4367.890802729926, 4398.978005109954, 4702.576768090888, 4723.692959957626, 4783.0, 4784.928226076577, 4841.128596852565, 4920.630952678528, 5098.872528186788, 5131.4098878629065, 5147.124988751922, 5211.166213405875, 5114.820981265638, 5189.04002759487, 5215.687058776485, 5232.738363081869, 5238.5023422774775, 4806.327114204014, 4844.176489996744, 4850.6362022848425, 4852.223644216979, 4855.854324370274, 5167.199084141964, 5211.374635043743, 5343.438938911436, 5345.973270133624, 5401.513863752281, 5042.596592272609, 5043.218301163325, 5062.645614807002, 5122.590192784568, 5123.308353372322, 5139.7687104080405, 5144.331236939174, 5145.331106956147, 5152.124138896396, 5214.0614689355525, 4896.46138924718, 4932.210846264652, 5100.56645185156, 5106.617003724736, 5111.948880511221, 5055.3428054353435, 5067.949320506747, 5137.332146820964, 5180.0, 5196.558292545176, 4352.086061927031, 4355.06366131277, 4357.629601483846, 4402.053558484941, 4405.449318835145, 3803.220339830328, 3836.616338366197, 3862.787546684903, 3866.149447121629, 3867.7679339239735, 4356.150550642595, 4380.6933514653665, 4452.844150454718, 4483.30508771141, 4493.370928070073, 5203.19350500673, 5204.21936709489, 5204.297419848272, 5206.505381988705, 5248.685078895279, 4453.844115455943, 4490.236659767847, 4490.910181796346, 4533.750643714628, 4537.727736335764, 4518.118966801442, 4575.267957126844, 4611.400517932714, 4622.329762184531, 4641.327007583882, 4822.107910036654, 4839.564439200489, 4842.0, 4886.902261954812, 4903.5586797188425, 5121.180611102206, 5140.100482415637, 5149.253358263106, 5153.0466863630345, 5157.484251574812, 4733.266343716729, 4787.593054590398, 4795.64032697556, 4841.733704646278, 4886.364772579542, 5033.0688822567945, 5051.848444546669, 5091.0, 5151.381834179922, 5151.5106064923775, 5139.974300128625, 5146.588272938081, 5147.124988751846, 5147.305113809588, 5196.896062078662, 4999.350084489139, 5015.17249653803, 5022.773975171053, 5025.296458495886, 5086.237064440364, 4865.781039853286, 4905.313256144214, 4940.036692844861, 4949.727764972961, 5005.199168133081, 4859.757012149307, 4861.635377346784, 4862.07620552094, 4875.512448755097, 4926.211806111005, 4929.926051109164, 4930.704157750546, 5002.974985125196, 5010.724410157331, 5020.723860187579, 4794.352762377034, 4961.280614310833, 4964.180910149929, 4966.826161084345, 5017.899642007066], "value": 4725.146888221227, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [524.769101595298, 558.9496945274924, 561.1554610311481, 573.9339975902769, 579.8869220502002, 30000.249993750167, 37828.243435131284, 38795.0, 38941.41587876177, 43683.78158109205, 40079.0, 40477.797611011905, 40565.39151912724, 40648.59351406485, 40651.186976260455, 7161.534500257467, 7538.246175382459, 7657.617119144048, 7710.922890771105, 7731.8067048323965, 9412.247020238365, 9713.32006759527, 9720.562574684156, 9995.2003839693, 10003.199744020461, 9771.804563908718, 9871.160951319147, 9875.555599998017, 9882.752931176707, 9892.060254275832, 9862.260330475207, 9922.950385248028, 9924.40453572788, 9925.801483970352, 9928.156106730936, 9789.951050244703, 9857.55640996157, 9858.211343092535, 9859.753506162331, 9867.60529578816, 37489.81255093707, 37755.433668494996, 37767.24465510702, 37799.43300850489, 37863.432048519295, 2913.6212292402065, 2958.5118455454826, 2964.7628189744983, 3033.605631267943, 3241.594800649919, 27990.720092799016, 28187.29531761702, 28531.144065677854, 28843.56734648982, 29094.27264318409, 3382.408078586262, 3524.506569080331, 3566.7503274770775, 3575.8748443804343, 3703.8333275002688, 245626.0, 246952.0, 247995.0, 248291.0, 249109.0, 51278.53904105781, 51588.74205628948, 51615.7419212909, 51657.0, 51711.48288517067, 31715.20711982219, 32800.50799238013, 32878.17804554857, 34881.0, 54948.0, 14561.490347837775, 15050.698986020438, 15057.247137643293, 15058.397664093533, 15061.322240499203, 10450.11174050199, 10737.087347575387, 11275.54897804095, 11345.659630211107, 11348.14888883337, 15531.5340539784, 17044.14779261057, 17727.0, 17798.110094495223, 18223.362182323555, 6639.834004149935, 6726.831829204309, 6730.125083739181, 6814.659267036628, 6829.760958366433, 788.6727008291609, 854.747849384433, 873.0, 912.7261821453537, 943.9811203775886, 27499.725002750118, 28210.576841347396, 28249.43501130007, 28589.428211435654, 28689.282767930552, 908.6774195160755, 941.6751220828803, 946.5078159357096, 954.5704433005176, 1047.7537778622018, 14758.040727352687, 14917.254137293092, 14976.475823346349, 15134.318955647022, 15241.0, 388840.0, 392238.0, 392918.0, 393011.0, 393456.0, 33370.33259334848, 33573.83213083919, 33747.66252337445, 50052.499475004784, 50123.0, 1025.29254814178, 1053.262716098734, 1149.5689116581282, 1149.7010777197822, 1163.2555164694602, 25410.364740881625, 28693.0, 28959.42081158407, 29534.261643459085, 29656.851715741283, 40602.79698601488, 41174.58825411827, 41179.38230926599, 41201.587984120975, 41296.0, 307222.0, 307812.0, 308968.0, 309186.0, 309397.0, 24462.87768561217, 25221.369465762768, 25551.0, 25633.0, 26582.86708566445, 40862.0, 41132.58867411407, 41337.79331103325, 41597.79201104096, 42547.787261063495, 34957.65042349544, 35023.0, 35439.29121417506, 35599.28801423905, 35820.462693060144, 33716.66283337135, 33979.4903076459, 34015.319693606485, 34021.0, 34037.319253615286, 34729.47905781466, 34980.65019349876, 35671.28657426889, 35751.10622234465, 35857.0, 30402.239944001576, 33291.334173316885, 33862.492062619574, 35640.643593563735, 36258.4561231587, 24824.25527234186, 25153.0, 25220.621690675023, 25488.617670735326, 25883.0], "value": 17500.51812061569, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.9667531584499, 354.65775526616795, 369.75780863534385, 370.7238107609831, 389.27206124547104, 12352.0, 15671.608209794747, 16086.75869861953, 16126.596835079128, 17231.569210769736, 15908.681826363465, 16240.187990600452, 17260.654786904255, 17425.30298788047, 17571.91214043931, 5043.546080852713, 5089.618278629099, 5168.483151684839, 5191.506806853343, 5203.531682148606, 3646.270745850827, 5097.209932460456, 5176.301199338098, 5177.068127737006, 5178.249153872686, 5627.577931655122, 5906.763729450817, 5938.584299099065, 6050.878982420349, 6063.636181829104, 5831.708414579297, 6016.037434010559, 6025.126356678301, 6086.786962456337, 6117.357677443893, 5379.946200537984, 5392.595555333326, 5392.676439413609, 5395.136778115482, 5400.78396864125, 19969.500762480908, 20520.486987825276, 20634.690479642817, 20648.277310294066, 20669.793302066937, 1754.4473490850469, 1802.2160360243336, 1838.273881816675, 2060.2377120465526, 2249.7975182233513, 12446.688832779162, 13194.67013324665, 13476.191428514321, 13558.93220533891, 13925.025248232629, 1743.232977489913, 1756.710142826432, 1781.1806568978157, 1785.589314457669, 1846.1046392499627, 66078.3392166077, 68359.0, 68433.0, 68904.31095689029, 71550.28449715437, 9500.809983800285, 9749.951250243703, 9807.950960245153, 10040.598376064876, 10122.0, 13295.933520332337, 13321.866781332257, 13377.063605547519, 13402.731945361038, 13406.798898016537, 7472.14070381913, 7476.775696729107, 7576.090869095744, 7660.578668173192, 7749.573773442402, 6731.730730770812, 6772.627505487147, 7081.504294699322, 7150.678219480136, 7387.741429049957, 6017.729202185912, 6126.142340072393, 6183.258009038944, 6264.37356264379, 6337.8732425352155, 1712.4520153550993, 1722.7415887616958, 1745.3891138101817, 1763.576741582011, 1780.7150855863, 769.6151924037981, 830.7175560309523, 865.6364326982557, 917.4220241247971, 955.9713208603753, 16249.837501625068, 16870.0, 17320.480385588453, 17322.913385432992, 18141.27434902589, 817.5421763812166, 820.0487434575863, 839.2237180607913, 856.486108334994, 886.3529623374973, 6847.417969472651, 9745.122938935388, 9775.31572789912, 10003.949980250052, 10030.398176109456, 401976.0, 412560.0, 422548.0, 423839.0, 424091.0, 82215.0, 84200.57899710462, 85254.57372713096, 85453.57273213594, 86904.0, 886.9157430044136, 902.4540153207215, 938.024454567256, 939.8543225799875, 941.7221919533754, 15556.766648500508, 15650.608734781721, 16287.51137465878, 16462.506124816275, 16705.415310464563, 37355.43966840554, 38752.22495550017, 38878.0, 39108.41337379999, 39332.80333598314, 48303.75848120737, 52494.95010099853, 53426.8629254841, 53507.0, 55934.0, 6613.173353330833, 6878.27778083314, 6902.792916212522, 7172.677229524579, 7550.0, 7281.672324745293, 7292.890606640798, 9194.724158275263, 9760.951195243979, 12025.75948481008, 10078.647247346307, 10250.128739057263, 10432.739181520523, 10901.201301785117, 10964.835527467254, 5885.293764748258, 6088.604240724516, 10365.896341036492, 10436.217283703601, 10486.318389304672, 10233.846492302473, 10431.94784026075, 10601.575936962436, 10618.946905265424, 10905.618303359344, 7006.334398232159, 7213.87190778711, 7265.636718164176, 7324.450666200163, 7670.27132422419, 8860.29117670572, 10460.738481538023, 10471.94764026175, 10591.311564748266, 11078.0], "value": 8316.825184968677, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1202.6933132051327, 1317.295247042832, 1362.7410791949533, 1409.3869166912393, 1656.0643236571336, 7326.340629343358, 7606.201348858373, 7681.923180768197, 7875.960620196905, 7889.684412623488, 7747.845043099134, 7869.291763741262, 7869.724559640414, 7870.212978702127, 7875.92124078759, 2171.5439757650875, 2197.6154173019736, 2198.505336299336, 2198.857074290166, 2199.7360316761933, 2135.9359219223447, 2170.066871245364, 2186.6392045312505, 2193.1008286602496, 2195.879226642534, 2165.436986383536, 2189.069645400706, 2189.704389907358, 2193.451637090727, 2204.6252137136726, 2044.0597325230412, 2046.5190680190144, 2050.507878109243, 2059.2998380550684, 2061.154926480136, 2090.2266161520183, 2145.1955516681246, 2147.903344349508, 2152.7954844289766, 2154.504463973279, 7433.368163706037, 7713.884291735629, 7763.456558040939, 7812.0, 7815.140334563193, 4433.756143412111, 4624.560666736655, 4628.8148474061, 4628.976855115703, 4633.32816741574, 2705.1208357283963, 2846.4876322261985, 2898.0581311073984, 2907.7964542482036, 2914.198595386286, 923.6166990698852, 924.4499522783933, 940.5720397219249, 940.83535381308, 945.3618807305041, 10546.050855422973, 10558.366498010068, 10568.0, 10614.363138211733, 10655.200859935536, 3879.243547508209, 4018.678505719535, 4181.60274773896, 4191.245575796325, 4224.1129362834145, 8685.696000640073, 8699.695510657224, 8710.21608055278, 8712.912870871336, 8714.52070136136, 4483.820647174141, 4522.977385113119, 4523.5024147343765, 4538.387317712132, 4558.908821823611, 3589.138606734365, 4100.7334523255895, 4155.4182414462, 4161.313383291784, 4229.788510574459, 3395.8132302723093, 3428.879989200366, 3528.382533056756, 3532.894013179609, 3556.1643013891717, 1013.4324778124274, 1020.5203554329602, 1028.0877567724028, 1037.222083437422, 1060.4644654449453, 745.273358475482, 752.9924700752922, 817.7505860712421, 833.8082241084585, 845.4842546046906, 5137.974310128426, 5152.9742351288005, 5235.3717553893775, 5322.866928326823, 5340.973295133499, 392.6230818414354, 402.57327233132975, 409.57608874814423, 412.1118988579616, 414.4674093789466, 3681.5950245472977, 3685.8157092145284, 3690.5975729222723, 3699.72252081095, 3793.8292776824555, 9684.70945871625, 9932.553035113437, 10022.448765317831, 10140.340877842917, 10148.441835699108, 9984.15134713543, 10040.598376065022, 10050.447225402673, 10056.944020877849, 10066.295359324924, 7456.813579660552, 7485.737999170003, 7512.361449276764, 7567.545947243183, 7571.621418929031, 5231.607629427732, 5329.73351332424, 5331.3868905076415, 5335.519803217574, 5346.572274217975, 8902.0, 8919.687810926587, 8923.286137109146, 8977.640894364413, 9028.052054534443, 8722.869156962524, 8941.597628106882, 9025.277977761894, 9120.133587309196, 9140.908590914272, 6155.907661384993, 6424.229092508929, 6681.933180668131, 6826.556273842184, 6832.521723479507, 7580.734674286374, 7772.650230739518, 7859.449838511478, 7860.528368297921, 7867.685292588232, 6769.323067693192, 6844.4524438043845, 6853.280405557344, 6859.519833611599, 7072.893906591303, 6752.0, 6752.5948443093575, 6771.984202369684, 6796.76211332601, 6884.070650462324, 6388.8083357499345, 6468.579542329733, 6482.222133344029, 6489.772857949949, 6491.870162596816, 4505.256632655575, 4520.6835521514495, 4562.087582483583, 4565.908681826411, 4623.445186577497, 4394.538573449741, 4444.0, 4449.065696203834, 4645.953540464552, 4794.5924596409695], "value": 4025.032032502512, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.4170625573875, 297.6428286056732, 303.99984052467374, 306.2160868177466, 308.6435167381675, 4922.360093187889, 4945.738836596667, 4955.405351357842, 4968.900621987567, 5001.574866136379, 4533.773311334437, 4701.9059618807605, 4704.270838020104, 4711.340412342275, 4830.623272367376, 3696.3716168251326, 3748.418995055764, 3756.3426400379963, 3821.9235615287816, 3837.57786643469, 3819.0141126614144, 3831.540215174183, 3835.3096442640312, 3842.7694338339647, 3860.0, 3559.4660800879815, 3729.482599245512, 3799.9430008549894, 3820.083180036785, 3825.234953009395, 3761.0, 3765.2093060457337, 3772.4718539404507, 3774.320622288001, 3774.792386418746, 3303.487959366302, 3303.884364047271, 3305.4215512285255, 3310.702036816698, 3314.5193946877566, 4721.716696998191, 4727.550882666142, 4734.455537613149, 4746.810127594892, 4752.263399173134, 4069.654079403225, 4310.1379724055005, 4311.568843115663, 4351.977285337943, 4375.409319741826, 5076.847694569169, 5092.574079257776, 5117.641765076446, 5119.180931051052, 5126.512981266774, 3635.0730563706084, 3637.6907962823193, 3639.399499082648, 3647.5075864758182, 3676.356637588411, 5106.923396149061, 5287.23335116406, 5314.92027619586, 5355.937963883933, 5365.731713414314, 3691.7046636269033, 3702.8703995360033, 3704.4258139988347, 3713.832877520518, 3721.209093180115, 3748.7375883688424, 3752.6247375262255, 3758.548974123068, 3759.342115129841, 3776.3580191367532, 4320.3519472078815, 4331.177076355482, 4334.1981733379425, 4341.978290108529, 4350.21696094706, 4954.752262386866, 5078.009788091286, 5089.312942752681, 5125.078095714107, 5132.2798916574275, 1301.6030110816102, 1305.2951406240713, 1305.8563558008611, 1311.672081979505, 1313.967150821237, 819.8319344534475, 923.1184219070772, 942.783159873233, 955.1613144696431, 956.8947415784259, 4449.332600109945, 4473.261911784584, 4478.880279930017, 4506.504284528699, 4516.432018705252, 5171.689698618095, 5194.870128246824, 5220.7128607926925, 5243.501867322599, 5249.947500525022, 4319.5386669181125, 4495.662825288116, 4515.638748900145, 4528.841490547881, 4550.840720574764, 2764.972350276512, 2768.321761168527, 2773.778097752175, 2777.666679998413, 2780.3466185446405, 4862.513748625109, 4886.338644860693, 4889.877753056202, 4890.095332363524, 4900.558949694545, 5159.716215608102, 5230.587741309825, 5255.947440525546, 5294.0, 5312.814051508179, 4838.879028024327, 4854.83008094722, 4864.878378040577, 4866.732329721828, 4867.415910090812, 5202.869928251824, 5204.776877433725, 5205.843824685266, 5206.869828254324, 5216.765245563883, 4902.436219834764, 5099.14447909172, 5144.202648589325, 5165.586753059671, 5166.509181627739, 4945.826896058621, 4950.6039516837845, 4951.925721114114, 4952.678075925053, 4954.108260513142, 3760.417135344026, 3766.6798322142927, 3780.5085338905765, 3785.5835858056143, 3786.5645450773513, 5149.536541711264, 5267.446918073547, 5296.496832801032, 5301.363836339664, 5356.5982551308025, 5123.538881500683, 5131.179011358165, 5144.871378215575, 5152.819651312186, 5164.612654050886, 5089.618278629192, 5140.43455219933, 5158.406783219978, 5160.0, 5165.121929272108, 4921.972986613278, 5033.446320904624, 5065.265536497261, 5067.341245638044, 5075.441701412916, 4921.311016457627, 4954.142196676246, 5127.53852153308, 5129.8717532062, 5142.76857541404, 5012.172991456368, 5012.498750124958, 5012.899742005213, 5022.84931452057, 5061.190209566599], "value": 3844.1976647183687, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.4722184757252, 570.2017175953664, 570.8601392658799, 602.6083046020086, 653.8561516466376, 12760.744785104303, 13279.800802987962, 13451.596452106429, 13940.860591394083, 13944.790828137573, 12852.67868303293, 13096.47614095435, 13109.737805243889, 13116.606501804938, 13123.6719082023, 596.5168213746879, 723.8154270660974, 741.8516296740646, 744.4937442539072, 744.7728442824963, 718.392957950531, 748.0275641665839, 750.5196674128562, 754.5698951597592, 755.962201889906, 788.1015642167933, 789.743333416639, 790.3913986230599, 790.8892755014302, 790.9920900790976, 617.6849806598622, 786.5438045933345, 788.2747871957813, 788.3102285500187, 788.6766425765466, 549.8377978496313, 565.2341077839551, 570.2529686111208, 570.4324197423549, 571.0691572736455, 13379.063465557414, 13413.128146670435, 13416.798748018788, 13420.328983550784, 13432.0, 11576.247543909703, 11888.940555297255, 12162.209456385395, 12217.93891030548, 12309.384530773426, 9279.860802087975, 9726.416415015052, 11154.944225278903, 11250.437478126143, 11373.886261137366, 3954.169624378884, 3986.4219688145345, 3989.98005009976, 3992.7803970781597, 4178.080822219107, 62226.37773622297, 62256.377436225965, 62569.37430625681, 63019.6849015752, 63484.682576587285, 9183.449432147025, 9254.444733316022, 9376.531173441437, 9401.71794846142, 9428.669996550088, 16772.0, 16779.83220167807, 16786.916065419595, 16794.412195573095, 16980.91509542469, 6210.875782484325, 6310.1796766420075, 6313.179286692793, 6437.0988061671405, 6485.286618471964, 3473.235888104613, 3496.982515087459, 3503.4219353806848, 3509.94735078974, 3545.0782796473104, 2785.818921770119, 2909.38902830408, 2915.5772413000423, 2916.1105862712075, 2918.1099764571586, 499.57785671107854, 509.3760143823786, 511.524282417348, 512.1984094891483, 517.8575891629832, 467.6422536759382, 506.37209859773617, 539.4389834572002, 541.4828838459262, 544.4609836262072, 6932.847376780625, 7255.419566434673, 7458.925410745932, 7507.324340809353, 7695.268949449905, 449.22060225508716, 506.16735470151394, 530.191458026505, 531.9867003324948, 540.1708377640304, 3428.8114153721285, 3460.1003739028033, 3550.6449355064287, 3571.7678350907627, 3616.620254873253, 97905.0, 101766.49116754517, 103905.0, 104659.47670261753, 104714.47642761738, 51942.48057519377, 52522.73738631359, 85713.28576928204, 87966.56016719875, 91291.0, 80077.0, 80383.0, 80411.0, 80860.0, 81566.0, 6603.471722262304, 6662.633555154319, 6788.4569234462115, 6823.795286141423, 6871.209810871814, 32253.677463225067, 46364.768176158905, 46691.533084670074, 47290.29064563965, 48392.27411588899, 38568.80715596404, 39788.602113978486, 65252.800983906454, 67201.66399167973, 67744.66127669527, 8945.19493245611, 9132.589033493641, 9272.165505104573, 10336.276460647983, 10511.632092876713, 12019.879801202225, 12305.876941230474, 12486.12597118193, 13264.071514993857, 13368.933155334551, 11743.236689615147, 11775.941120294343, 12277.26336419782, 12570.748585028432, 12678.0, 11622.6513204604, 11706.180567360203, 12001.099917506048, 12261.509539618315, 12636.178648387826, 10824.4046577439, 11450.541978321107, 11485.540578376771, 11522.193446458667, 11656.53373865036, 9338.206252468617, 9664.806703866025, 9751.0, 9799.804003920024, 10198.847017294895, 9216.493092879688, 9285.953570232376, 9350.812983740423, 9375.906240937504, 9446.527673616429], "value": 6283.866092501786, "unit": "score"}], "name": "dromaeo_css", "value": 6371.073477890891, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 119.0, 116.0, 114.0, 114.0, 114.0, 115.0, 115.0, 130.0], "value": 116.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 124.0, 146.0, 183.0, 123.0, 148.0, 144.0, 126.0, 196.0, 124.0], "value": 146.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 163.0, 164.0, 162.0, 161.0, 161.0, 162.0, 160.0, 160.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 171.0, 77.0, 76.0, 76.0, 76.0, 160.0, 76.0], "value": 94.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 158.0, 84.0, 84.0, 83.0, 137.0, 83.0, 82.0, 141.0], "value": 101.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 147.0, 146.0, 145.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 94.0, 95.0, 96.0, 95.0, 95.0, 96.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 68.0, 65.0, 67.0, 67.0, 66.0, 65.0, 66.0], "value": 66.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 67.0, 66.0, 66.0, 67.0, 66.0, 66.0, 67.0], "value": 66.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 82.0, 82.0, 90.0, 91.0, 84.0, 81.0, 81.0, 82.0], "value": 83.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 142.0, 132.0, 139.0, 133.0, 149.0, 133.0, 133.0, 183.0, 133.0], "value": 142.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 177.0, 173.0, 175.0, 175.0, 172.0, 179.0, 173.0, 171.0, 172.0], "value": 174.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 69.0, 71.0, 68.0, 72.0, 69.0, 69.0, 68.0, 67.0, 68.0], "value": 69.2, "unit": "score"}], "name": "kraken", "value": 1580.7000000000003, "alertThreshold": 2.0}]} 18:42:07 INFO - Return code: 0 18:42:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:42:07 INFO - # TBPL SUCCESS # 18:42:07 INFO - Running post-action listener: _resource_record_post_action 18:42:07 INFO - [mozharness: 2016-09-02 01:42:07.717968Z] Finished run-tests step (success) 18:42:07 INFO - Running post-run listener: _resource_record_post_run 18:42:07 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 416686080; Read time: 16; Write time: 258404 18:42:07 INFO - TinderboxPrint: CPU usage
13.0% 18:42:07 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 18:42:07 INFO - TinderboxPrint: I/O write bytes / time
416,686,080 / 258,404 18:42:07 INFO - TinderboxPrint: CPU idle
8,355.2 (87.0%) 18:42:07 INFO - TinderboxPrint: CPU user
1,202.4 (12.5%) 18:42:07 INFO - TinderboxPrint: Swap in / out
0 / 0 18:42:07 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 124940288; Read time: 0; Write time: 84200 18:42:07 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 290799616; Read time: 0; Write time: 174176 18:42:08 INFO - Running post-run listener: _upload_blobber_files 18:42:08 INFO - Blob upload gear active. 18:42:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:42:08 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 18:42:08 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:42:08 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:42:08 INFO - (blobuploader) - INFO - Open directory for files ... 18:42:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:42:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:42:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:42:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:42:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:42:10 INFO - (blobuploader) - INFO - Done attempting. 18:42:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:42:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:42:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:42:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:42:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:42:11 INFO - (blobuploader) - INFO - Done attempting. 18:42:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:42:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:42:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:42:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:42:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:42:15 INFO - (blobuploader) - INFO - Done attempting. 18:42:15 INFO - (blobuploader) - INFO - Iteration through files over. 18:42:15 INFO - Return code: 0 18:42:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:42:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:42:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1cffdcb4929ec8b38b8dde65be132e7ed0fa39f480ae470ba3422530e9da6aff1272af91dab58cb7fd19ca8ecceaeccf36d8cb46ae98cfa18a2fbc0d0e0ec20c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e571ca41b7c2b1a99af90b9f725fe677d8cb1870c4c845b1b63d84a389aefda543d2cb635a500ca3d00e240ed5641bc0f857563a282bed4f22fea2b309f593a7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6e54761075e6393c7fe295840e2f6a568087bea0fc15b53464e6657610ec38544fba7fc37756d078e5f607a06fa06fa2ac35613fb37f2de7cd251133936daebe"} 18:42:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:42:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:42:15 INFO - Contents: 18:42:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1cffdcb4929ec8b38b8dde65be132e7ed0fa39f480ae470ba3422530e9da6aff1272af91dab58cb7fd19ca8ecceaeccf36d8cb46ae98cfa18a2fbc0d0e0ec20c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e571ca41b7c2b1a99af90b9f725fe677d8cb1870c4c845b1b63d84a389aefda543d2cb635a500ca3d00e240ed5641bc0f857563a282bed4f22fea2b309f593a7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6e54761075e6393c7fe295840e2f6a568087bea0fc15b53464e6657610ec38544fba7fc37756d078e5f607a06fa06fa2ac35613fb37f2de7cd251133936daebe"} 18:42:15 INFO - Running post-run listener: copy_logs_to_upload_dir 18:42:15 INFO - Copying logs to upload dir... 18:42:15 INFO - mkdir: /builds/slave/test/build/upload/logs 18:42:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.010364 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-09-01 18:42:14.657861) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-01 18:42:14.664478) ========= 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=7de08804244eb36560b44971000001c3-1472775031.950260-588082060 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-Non-PGO/sha512/1cffdcb4929ec8b38b8dde65be132e7ed0fa39f480ae470ba3422530e9da6aff1272af91dab58cb7fd19ca8ecceaeccf36d8cb46ae98cfa18a2fbc0d0e0ec20c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e571ca41b7c2b1a99af90b9f725fe677d8cb1870c4c845b1b63d84a389aefda543d2cb635a500ca3d00e240ed5641bc0f857563a282bed4f22fea2b309f593a7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6e54761075e6393c7fe295840e2f6a568087bea0fc15b53464e6657610ec38544fba7fc37756d078e5f607a06fa06fa2ac35613fb37f2de7cd251133936daebe"} build_url:https://queue.taskcluster.net/v1/task/bsVgSYJRQNq2IAukgZ7Clw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011330 build_url: 'https://queue.taskcluster.net/v1/task/bsVgSYJRQNq2IAukgZ7Clw/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-Non-PGO/sha512/1cffdcb4929ec8b38b8dde65be132e7ed0fa39f480ae470ba3422530e9da6aff1272af91dab58cb7fd19ca8ecceaeccf36d8cb46ae98cfa18a2fbc0d0e0ec20c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e571ca41b7c2b1a99af90b9f725fe677d8cb1870c4c845b1b63d84a389aefda543d2cb635a500ca3d00e240ed5641bc0f857563a282bed4f22fea2b309f593a7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6e54761075e6393c7fe295840e2f6a568087bea0fc15b53464e6657610ec38544fba7fc37756d078e5f607a06fa06fa2ac35613fb37f2de7cd251133936daebe"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-01 18:42:14.689301) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 18:42:14.689639) ========= 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=7de08804244eb36560b44971000001c3-1472775031.950260-588082060 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004395 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 18:42:14.771896) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-01 18:42:14.772226) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-01 18:42:14.772526) ========= ========= Total master_lag: 0.19 =========