builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-003 starttime: 1491072968.55 results: success (0) revision: 7a3f514cf8490d271ee373a1d2999e4ea4dee2d7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-01 11:56:08.552432) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-01 11:56:08.552897) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-01 11:56:08.553462) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-01 11:56:08.612856) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-01 11:56:08.613128) ========= 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-1491071570.662924-91094382 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-04-01 11:56:08-- 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: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 229M=0s 2017-04-01 11:56:08 (229 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.162444 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-01 11:56:08.818830) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-01 11:56:08.819137) ========= 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-1491071570.662924-91094382 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.083735 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-01 11:56:08.915416) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-01 11:56:08.915744) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7a3f514cf8490d271ee373a1d2999e4ea4dee2d7 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 7a3f514cf8490d271ee373a1d2999e4ea4dee2d7 --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-1491071570.662924-91094382 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-04-01 11:56:08,935 truncating revision to first 12 chars 2017-04-01 11:56:08,935 Setting DEBUG logging. 2017-04-01 11:56:08,936 attempt 1/10 2017-04-01 11:56:08,936 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7a3f514cf849?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-01 11:56:09,328 unpacking tar archive at: mozilla-central-7a3f514cf849/testing/mozharness/ program finished with exit code 0 elapsedTime=0.727674 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-01 11:56:09.657503) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-01 11:56:09.657870) ========= script_repo_revision: 7a3f514cf8490d271ee373a1d2999e4ea4dee2d7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-01 11:56:09.658283) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-01 11:56:09.658565) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-01 11:56:09.669740) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2017-04-01 11:56:09.670033) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7de08804244eb36560b44971000001c3-1491071570.662924-91094382 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:56:09 INFO - MultiFileLogger online at 20170401 11:56:09 in /builds/slave/test 11:56:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 11:56:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:56:09 INFO - {'append_to_log': False, 11:56:09 INFO - 'base_work_dir': '/builds/slave/test', 11:56:09 INFO - 'blob_upload_branch': 'Firefox', 11:56:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:56:09 INFO - 'branch': 'Firefox', 11:56:09 INFO - 'buildbot_json_path': 'buildprops.json', 11:56:09 INFO - 'config_files': ('talos/linux_config.py',), 11:56:09 INFO - 'default_actions': ('clobber', 11:56:09 INFO - 'read-buildbot-config', 11:56:09 INFO - 'download-and-extract', 11:56:09 INFO - 'populate-webroot', 11:56:09 INFO - 'create-virtualenv', 11:56:09 INFO - 'install', 11:56:09 INFO - 'run-tests'), 11:56:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:56:09 INFO - 'download_minidump_stackwalk': True, 11:56:09 INFO - 'download_symbols': 'ondemand', 11:56:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:56:09 INFO - 'tooltool.py': '/tools/tooltool.py', 11:56:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:56:09 INFO - '/tools/misc-python/virtualenv.py')}, 11:56:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:56:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:56:09 INFO - 'gecko_profile': False, 11:56:09 INFO - 'gecko_profile_interval': 0, 11:56:09 INFO - 'installer_path': 'installer.exe', 11:56:09 INFO - 'log_level': 'info', 11:56:09 INFO - 'log_name': 'talos', 11:56:09 INFO - 'log_to_console': True, 11:56:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:56:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:56:09 INFO - 'opt_config_files': (), 11:56:09 INFO - 'pip_index': False, 11:56:09 INFO - 'suite': 'dromaeojs', 11:56:09 INFO - 'system_bits': '32', 11:56:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:56:09 INFO - 'title': 'talos-linux64-ix-003', 11:56:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:56:09 INFO - 'use_talos_json': True, 11:56:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:56:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:56:09 INFO - 'work_dir': 'build'} 11:56:09 INFO - [mozharness: 2017-04-01 18:56:09.883309Z] Running clobber step. 11:56:09 INFO - Running pre-action listener: _resource_record_pre_action 11:56:09 INFO - Running main action method: clobber 11:56:09 INFO - rmtree: /builds/slave/test/build 11:56:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:56:15 INFO - Running post-action listener: _resource_record_post_action 11:56:15 INFO - [mozharness: 2017-04-01 18:56:15.942056Z] Finished clobber step (success) 11:56:15 INFO - [mozharness: 2017-04-01 18:56:15.942154Z] Running read-buildbot-config step. 11:56:15 INFO - Running pre-action listener: _resource_record_pre_action 11:56:15 INFO - Running main action method: read_buildbot_config 11:56:15 INFO - Using buildbot properties: 11:56:15 INFO - { 11:56:15 INFO - "project": "", 11:56:15 INFO - "product": "firefox", 11:56:15 INFO - "who": "archaeopteryx@coole-files.de", 11:56:15 INFO - "installer_path": "public/build/target.tar.bz2", 11:56:15 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 11:56:15 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 11:56:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 11:56:15 INFO - "stage_platform": "linux64-pgo", 11:56:15 INFO - "basedir": "/builds/slave/test", 11:56:15 INFO - "buildnumber": 105, 11:56:15 INFO - "platform": "ubuntu64_hw", 11:56:15 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:56:15 INFO - "slavebuilddir": "test", 11:56:15 INFO - "taskId": "R_LL1guIRkOrrbJvm0uGHQ", 11:56:15 INFO - "branch": "mozilla-central", 11:56:15 INFO - "script_repo_revision": "production", 11:56:15 INFO - "revision": "7a3f514cf8490d271ee373a1d2999e4ea4dee2d7", 11:56:15 INFO - "slavename": "talos-linux64-ix-003", 11:56:15 INFO - "repo_path": "mozilla-central" 11:56:15 INFO - } 11:56:15 INFO - Finding installer, test and symbols from parent task. 11:56:15 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/R_LL1guIRkOrrbJvm0uGHQ'}, attempt #1 11:56:16 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/R_LL1guIRkOrrbJvm0uGHQ'}, attempt #1 11:56:16 INFO - Task dependencies: Nzt4cWyVR9CwgazV4zVRow 11:56:16 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Nzt4cWyVR9CwgazV4zVRow'}, attempt #1 11:56:17 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Nzt4cWyVR9CwgazV4zVRow/artifacts/public/build/target.tar.bz2 11:56:17 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Nzt4cWyVR9CwgazV4zVRow/artifacts/public/build/test_packages.json 11:56:17 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Nzt4cWyVR9CwgazV4zVRow/artifacts/public/build/target.crashreporter-symbols.zip 11:56:17 INFO - Running post-action listener: _resource_record_post_action 11:56:17 INFO - [mozharness: 2017-04-01 18:56:17.337103Z] Finished read-buildbot-config step (success) 11:56:17 INFO - [mozharness: 2017-04-01 18:56:17.337319Z] Running download-and-extract step. 11:56:17 INFO - Running pre-action listener: _resource_record_pre_action 11:56:17 INFO - Running main action method: download_and_extract 11:56:17 INFO - mkdir: /builds/slave/test/build/tests 11:56:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:56:17 INFO - trying https://queue.taskcluster.net/v1/task/Nzt4cWyVR9CwgazV4zVRow/artifacts/public/build/target.test_packages.json 11:56:17 INFO - Downloading https://queue.taskcluster.net/v1/task/Nzt4cWyVR9CwgazV4zVRow/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:56:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Nzt4cWyVR9CwgazV4zVRow/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:56:17 INFO - Downloaded 986 bytes. 11:56:17 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:56:17 INFO - Using the following test package requirements: 11:56:17 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:56:17 INFO - u'common': [u'target.common.tests.zip'], 11:56:17 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:56:17 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:56:17 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:56:17 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:56:17 INFO - u'mozbase': [u'target.common.tests.zip'], 11:56:17 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:56:17 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:56:17 INFO - u'web-platform': [u'target.common.tests.zip', 11:56:17 INFO - u'target.web-platform.tests.zip'], 11:56:17 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:56:17 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 11:56:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Nzt4cWyVR9CwgazV4zVRow/artifacts/public/build/target.common.tests.zip 11:56:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Nzt4cWyVR9CwgazV4zVRow/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:56:17 INFO - Fetch https://queue.taskcluster.net/v1/task/Nzt4cWyVR9CwgazV4zVRow/artifacts/public/build/target.common.tests.zip into memory 11:56:19 INFO - Expected file size: 60363913 11:56:19 INFO - Obtained file size: 60363913 11:56:29 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 11:56:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Nzt4cWyVR9CwgazV4zVRow/artifacts/public/build/target.common.tests.zip 11:56:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Nzt4cWyVR9CwgazV4zVRow/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:56:29 INFO - Fetch https://queue.taskcluster.net/v1/task/Nzt4cWyVR9CwgazV4zVRow/artifacts/public/build/target.common.tests.zip into memory 11:56:30 INFO - Expected file size: 60363913 11:56:30 INFO - Obtained file size: 60363913 11:56:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Nzt4cWyVR9CwgazV4zVRow/artifacts/public/build/target.talos.tests.zip 11:56:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Nzt4cWyVR9CwgazV4zVRow/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:56:42 INFO - Fetch https://queue.taskcluster.net/v1/task/Nzt4cWyVR9CwgazV4zVRow/artifacts/public/build/target.talos.tests.zip into memory 11:56:43 INFO - Expected file size: 14404152 11:56:43 INFO - Obtained file size: 14404152 11:56:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:56:43 INFO - trying https://queue.taskcluster.net/v1/task/Nzt4cWyVR9CwgazV4zVRow/artifacts/public/build/target.tar.bz2 11:56:43 INFO - Downloading https://queue.taskcluster.net/v1/task/Nzt4cWyVR9CwgazV4zVRow/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:56:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Nzt4cWyVR9CwgazV4zVRow/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:56:44 INFO - Downloaded 67948581 bytes. 11:56:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Nzt4cWyVR9CwgazV4zVRow/artifacts/public/build/target.tar.bz2 11:56:44 INFO - mkdir: /builds/slave/test/properties 11:56:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:56:44 INFO - Writing to file /builds/slave/test/properties/build_url 11:56:44 INFO - Contents: 11:56:44 INFO - build_url:https://queue.taskcluster.net/v1/task/Nzt4cWyVR9CwgazV4zVRow/artifacts/public/build/target.tar.bz2 11:56:44 INFO - Running post-action listener: _resource_record_post_action 11:56:44 INFO - Running post-action listener: set_extra_try_arguments 11:56:44 INFO - [mozharness: 2017-04-01 18:56:44.885489Z] Finished download-and-extract step (success) 11:56:44 INFO - [mozharness: 2017-04-01 18:56:44.885585Z] Running populate-webroot step. 11:56:44 INFO - Running pre-action listener: _resource_record_pre_action 11:56:44 INFO - Running main action method: populate_webroot 11:56:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:56:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:56:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:56:44 INFO - '--tppagecycles', 11:56:44 INFO - '7'], 11:56:44 INFO - 'tests': ['tsvgm']}}, 11:56:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:56:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:56:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:56:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:56:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:56:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:56:44 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 11:56:44 INFO - 'talos_options': ['--disable-e10s'], 11:56:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:56:44 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:56:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:56:44 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 11:56:44 INFO - 'talos_options': ['--disable-e10s'], 11:56:44 INFO - 'tests': ['damp', 'tps']}, 11:56:44 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:56:44 INFO - 'tests': ['damp', 'tps']}, 11:56:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:56:44 INFO - 'tests': ['dromaeo_dom']}, 11:56:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:56:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:56:44 INFO - 'tests': ['basic_compositor_video']}, 11:56:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:56:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:56:44 INFO - 'tests': ['a11yr', 11:56:44 INFO - 'ts_paint', 11:56:44 INFO - 'tpaint', 11:56:44 INFO - 'sessionrestore', 11:56:44 INFO - 'sessionrestore_no_auto_restore', 11:56:44 INFO - 'tabpaint']}, 11:56:44 INFO - 'other-e10s': {'tests': ['a11yr', 11:56:44 INFO - 'ts_paint', 11:56:44 INFO - 'tpaint', 11:56:44 INFO - 'sessionrestore', 11:56:44 INFO - 'sessionrestore_no_auto_restore', 11:56:44 INFO - 'tabpaint']}, 11:56:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:56:44 INFO - 'ts_paint', 11:56:44 INFO - 'tpaint', 11:56:44 INFO - 'sessionrestore', 11:56:44 INFO - 'sessionrestore_no_auto_restore', 11:56:44 INFO - 'tabpaint']}, 11:56:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:56:44 INFO - 'ts_paint', 11:56:44 INFO - 'tpaint', 11:56:44 INFO - 'sessionrestore', 11:56:44 INFO - 'sessionrestore_no_auto_restore', 11:56:44 INFO - 'tabpaint']}, 11:56:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:56:44 INFO - 'tests': ['a11yr', 11:56:44 INFO - 'ts_paint', 11:56:44 INFO - 'tpaint', 11:56:44 INFO - 'sessionrestore', 11:56:44 INFO - 'sessionrestore_no_auto_restore', 11:56:44 INFO - 'tabpaint']}, 11:56:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:56:44 INFO - 'tests': ['a11yr', 11:56:44 INFO - 'ts_paint', 11:56:44 INFO - 'tpaint', 11:56:44 INFO - 'sessionrestore', 11:56:44 INFO - 'sessionrestore_no_auto_restore', 11:56:44 INFO - 'tabpaint']}, 11:56:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:56:44 INFO - 'tests': ['tsvgx', 11:56:44 INFO - 'tsvgr_opacity', 11:56:44 INFO - 'tart', 11:56:44 INFO - 'tscrollx', 11:56:44 INFO - 'cart', 11:56:44 INFO - 'tsvg_static']}, 11:56:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:56:44 INFO - 'tsvgr_opacity', 11:56:44 INFO - 'tart', 11:56:44 INFO - 'tscrollx', 11:56:44 INFO - 'cart', 11:56:44 INFO - 'tsvg_static']}, 11:56:44 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 11:56:44 INFO - 'talos_options': ['--disable-e10s'], 11:56:44 INFO - 'tests': ['tp5o']}, 11:56:44 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:56:44 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 11:56:44 INFO - 'talos_options': ['--disable-e10s', 11:56:44 INFO - '--xperf_path', 11:56:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:56:44 INFO - 'tests': ['tp5n']}, 11:56:44 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:56:44 INFO - 'talos_options': ['--xperf_path', 11:56:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:56:44 INFO - 'tests': ['tp5n']}}, 11:56:44 INFO - 'talos.zip': {'path': '', 11:56:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:56:44 INFO - Running post-action listener: _resource_record_post_action 11:56:44 INFO - [mozharness: 2017-04-01 18:56:44.898654Z] Finished populate-webroot step (success) 11:56:44 INFO - [mozharness: 2017-04-01 18:56:44.898744Z] Running create-virtualenv step. 11:56:44 INFO - Running pre-action listener: _resource_record_pre_action 11:56:44 INFO - Running main action method: create_virtualenv 11:56:44 INFO - Creating virtualenv /builds/slave/test/build/venv 11:56:44 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:56:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:56:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:56:45 INFO - Using real prefix '/usr' 11:56:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:56:45 INFO - Installing distribute.............................................................................................................................................................................................done. 11:56:47 INFO - Installing pip.................done. 11:56:47 INFO - Return code: 0 11:56:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:56:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:56:47 INFO - Reading from file tmpfile_stdout 11:56:47 INFO - Output received: 11:56:47 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 11:56:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:56:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:56:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:56:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:56:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:56:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:56: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x270d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ab310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a8400>, '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 0x29a93b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29a9840>, '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-1491071570.662924-91094382', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:56: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', 'pip>=1.5'] in /builds/slave/test/build 11:56: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 pip>=1.5 11:56:47 INFO - Using env: {'DISPLAY': ':0', 11:56:47 INFO - 'HOME': '/home/cltbld', 11:56:47 INFO - 'LANG': 'en_US.UTF-8', 11:56:47 INFO - 'LANGUAGE': 'en_US:en', 11:56:47 INFO - 'LOGNAME': 'cltbld', 11:56:47 INFO - 'MAIL': '/var/mail/cltbld', 11:56:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:56:47 INFO - 'MOZ_NO_REMOTE': '1', 11:56:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:56:47 INFO - 'NO_EM_RESTART': '1', 11:56:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:56:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:56:47 INFO - 'PWD': '/builds/slave/test', 11:56:47 INFO - 'SHELL': '/bin/bash', 11:56:47 INFO - 'SHLVL': '1', 11:56:47 INFO - 'TERM': 'linux', 11:56:47 INFO - 'TMOUT': '86400', 11:56:47 INFO - 'USER': 'cltbld', 11:56:47 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1491071570.662924-91094382', 11:56:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:56:47 INFO - '_': '/tools/buildbot/bin/python'} 11:56:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:56:48 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:56:48 INFO - Cleaning up... 11:56:48 INFO - Return code: 0 11:56:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:56:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:56:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:56:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:56:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:56:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:56:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:56:48 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 0x270d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ab310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a8400>, '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 0x29a93b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29a9840>, '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-1491071570.662924-91094382', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:56:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:56:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:56:48 INFO - Using env: {'DISPLAY': ':0', 11:56:48 INFO - 'HOME': '/home/cltbld', 11:56:48 INFO - 'LANG': 'en_US.UTF-8', 11:56:48 INFO - 'LANGUAGE': 'en_US:en', 11:56:48 INFO - 'LOGNAME': 'cltbld', 11:56:48 INFO - 'MAIL': '/var/mail/cltbld', 11:56:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:56:48 INFO - 'MOZ_NO_REMOTE': '1', 11:56:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:56:48 INFO - 'NO_EM_RESTART': '1', 11:56:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:56:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:56:48 INFO - 'PWD': '/builds/slave/test', 11:56:48 INFO - 'SHELL': '/bin/bash', 11:56:48 INFO - 'SHLVL': '1', 11:56:48 INFO - 'TERM': 'linux', 11:56:48 INFO - 'TMOUT': '86400', 11:56:48 INFO - 'USER': 'cltbld', 11:56:48 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1491071570.662924-91094382', 11:56:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:56:48 INFO - '_': '/tools/buildbot/bin/python'} 11:56:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:56:48 INFO - Downloading/unpacking psutil>=3.1.1 11:56:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:56:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:56:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:56:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:56:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:56:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:56:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:56:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:56:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:56:50 INFO - Installing collected packages: psutil 11:56:50 INFO - Running setup.py install for psutil 11:56:50 INFO - building 'psutil._psutil_linux' extension 11:56:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:56:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:56:51 INFO - building 'psutil._psutil_posix' extension 11:56:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:56:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:56:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:56:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:56:52 INFO - Successfully installed psutil 11:56:52 INFO - Cleaning up... 11:56:52 INFO - Return code: 0 11:56:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:56: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')]} 11:56:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:56:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:56: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')]} 11:56:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:56:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:56: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x270d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ab310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a8400>, '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 0x29a93b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29a9840>, '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-1491071570.662924-91094382', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:56: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:56: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 mozsystemmonitor==0.3 11:56:52 INFO - Using env: {'DISPLAY': ':0', 11:56:52 INFO - 'HOME': '/home/cltbld', 11:56:52 INFO - 'LANG': 'en_US.UTF-8', 11:56:52 INFO - 'LANGUAGE': 'en_US:en', 11:56:52 INFO - 'LOGNAME': 'cltbld', 11:56:52 INFO - 'MAIL': '/var/mail/cltbld', 11:56:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:56:52 INFO - 'MOZ_NO_REMOTE': '1', 11:56:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:56:52 INFO - 'NO_EM_RESTART': '1', 11:56:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:56:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:56:52 INFO - 'PWD': '/builds/slave/test', 11:56:52 INFO - 'SHELL': '/bin/bash', 11:56:52 INFO - 'SHLVL': '1', 11:56:52 INFO - 'TERM': 'linux', 11:56:52 INFO - 'TMOUT': '86400', 11:56:52 INFO - 'USER': 'cltbld', 11:56:52 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1491071570.662924-91094382', 11:56:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:56:52 INFO - '_': '/tools/buildbot/bin/python'} 11:56:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:56:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:56: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 11:56: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 11:56: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 11:56: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 11:56: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 11:56: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 11:56:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:56:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:56:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:56:54 INFO - Installing collected packages: mozsystemmonitor 11:56:54 INFO - Running setup.py install for mozsystemmonitor 11:56:54 INFO - Successfully installed mozsystemmonitor 11:56:54 INFO - Cleaning up... 11:56:54 INFO - Return code: 0 11:56:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:56:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:56:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:56:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:56:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:56:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:56:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:56:54 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 0x270d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ab310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a8400>, '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 0x29a93b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29a9840>, '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-1491071570.662924-91094382', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:56:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:56:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:56:54 INFO - Using env: {'DISPLAY': ':0', 11:56:54 INFO - 'HOME': '/home/cltbld', 11:56:54 INFO - 'LANG': 'en_US.UTF-8', 11:56:54 INFO - 'LANGUAGE': 'en_US:en', 11:56:54 INFO - 'LOGNAME': 'cltbld', 11:56:54 INFO - 'MAIL': '/var/mail/cltbld', 11:56:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:56:54 INFO - 'MOZ_NO_REMOTE': '1', 11:56:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:56:54 INFO - 'NO_EM_RESTART': '1', 11:56:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:56:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:56:54 INFO - 'PWD': '/builds/slave/test', 11:56:54 INFO - 'SHELL': '/bin/bash', 11:56:54 INFO - 'SHLVL': '1', 11:56:54 INFO - 'TERM': 'linux', 11:56:54 INFO - 'TMOUT': '86400', 11:56:54 INFO - 'USER': 'cltbld', 11:56:54 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1491071570.662924-91094382', 11:56:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:56:54 INFO - '_': '/tools/buildbot/bin/python'} 11:56:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:56:54 INFO - Downloading/unpacking jsonschema==2.5.1 11:56: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 11:56: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 11:56: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 11:56: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 11:56: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 11:56: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 11:56:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:56:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:56:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:56:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:56:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:56:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:56:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:56:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:56:56 INFO - Downloading functools32-3.2.3-2.tar.gz 11:56:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:56:57 INFO - warning: no files found matching '*.txt' 11:56:57 INFO - no previously-included directories found matching 'build' 11:56:57 INFO - no previously-included directories found matching 'dist' 11:56:57 INFO - no previously-included directories found matching '.git*' 11:56:57 INFO - Installing collected packages: jsonschema, functools32 11:56:57 INFO - Running setup.py install for functools32 11:56:57 INFO - warning: no files found matching '*.txt' 11:56:57 INFO - no previously-included directories found matching 'build' 11:56:57 INFO - no previously-included directories found matching 'dist' 11:56:57 INFO - no previously-included directories found matching '.git*' 11:56:57 INFO - Successfully installed jsonschema functools32 11:56:57 INFO - Cleaning up... 11:56:57 INFO - Return code: 0 11:56:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:56:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:56:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:56:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:56:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:56:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:56:57 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 0x270d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ab310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a8400>, '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 0x29a93b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29a9840>, '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-1491071570.662924-91094382', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:56:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:56:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:56:57 INFO - Using env: {'DISPLAY': ':0', 11:56:57 INFO - 'HOME': '/home/cltbld', 11:56:57 INFO - 'LANG': 'en_US.UTF-8', 11:56:57 INFO - 'LANGUAGE': 'en_US:en', 11:56:57 INFO - 'LOGNAME': 'cltbld', 11:56:57 INFO - 'MAIL': '/var/mail/cltbld', 11:56:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:56:57 INFO - 'MOZ_NO_REMOTE': '1', 11:56:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:56:57 INFO - 'NO_EM_RESTART': '1', 11:56:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:56:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:56:57 INFO - 'PWD': '/builds/slave/test', 11:56:57 INFO - 'SHELL': '/bin/bash', 11:56:57 INFO - 'SHLVL': '1', 11:56:57 INFO - 'TERM': 'linux', 11:56:57 INFO - 'TMOUT': '86400', 11:56:57 INFO - 'USER': 'cltbld', 11:56:57 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1491071570.662924-91094382', 11:56:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:56:57 INFO - '_': '/tools/buildbot/bin/python'} 11:56:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:56:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:56:57 INFO - Cleaning up... 11:56:57 INFO - Return code: 0 11:56:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:56:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:56:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:56:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:56:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:56:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:56:57 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 0x270d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ab310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a8400>, '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 0x29a93b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29a9840>, '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-1491071570.662924-91094382', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:56:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:56:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:56:57 INFO - Using env: {'DISPLAY': ':0', 11:56:57 INFO - 'HOME': '/home/cltbld', 11:56:57 INFO - 'LANG': 'en_US.UTF-8', 11:56:57 INFO - 'LANGUAGE': 'en_US:en', 11:56:57 INFO - 'LOGNAME': 'cltbld', 11:56:57 INFO - 'MAIL': '/var/mail/cltbld', 11:56:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:56:57 INFO - 'MOZ_NO_REMOTE': '1', 11:56:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:56:57 INFO - 'NO_EM_RESTART': '1', 11:56:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:56:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:56:57 INFO - 'PWD': '/builds/slave/test', 11:56:57 INFO - 'SHELL': '/bin/bash', 11:56:57 INFO - 'SHLVL': '1', 11:56:57 INFO - 'TERM': 'linux', 11:56:57 INFO - 'TMOUT': '86400', 11:56:57 INFO - 'USER': 'cltbld', 11:56:57 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1491071570.662924-91094382', 11:56:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:56:57 INFO - '_': '/tools/buildbot/bin/python'} 11:56:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:56:57 INFO - Downloading/unpacking blobuploader==1.2.4 11:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:56:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:56:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:56:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:56:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:56:59 INFO - Downloading blobuploader-1.2.4.tar.gz 11:56:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:56:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:56:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:56:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:56:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:56:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:56:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:56:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:57:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:57:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:57: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 11:57: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 11:57: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 11:57: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 11:57: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 11:57: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 11:57:00 INFO - Downloading docopt-0.6.1.tar.gz 11:57:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:57:00 INFO - Installing collected packages: blobuploader, requests, docopt 11:57:00 INFO - Running setup.py install for blobuploader 11:57:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:57:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:57:00 INFO - Running setup.py install for requests 11:57:00 INFO - Running setup.py install for docopt 11:57:01 INFO - Successfully installed blobuploader requests docopt 11:57:01 INFO - Cleaning up... 11:57:01 INFO - Return code: 0 11:57:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:57:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:57:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:57:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:57:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:57:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:57:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:57:01 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 0x270d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ab310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a8400>, '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 0x29a93b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29a9840>, '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-1491071570.662924-91094382', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:57:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:57:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:57:01 INFO - Using env: {'DISPLAY': ':0', 11:57:01 INFO - 'HOME': '/home/cltbld', 11:57:01 INFO - 'LANG': 'en_US.UTF-8', 11:57:01 INFO - 'LANGUAGE': 'en_US:en', 11:57:01 INFO - 'LOGNAME': 'cltbld', 11:57:01 INFO - 'MAIL': '/var/mail/cltbld', 11:57:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:57:01 INFO - 'MOZ_NO_REMOTE': '1', 11:57:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:57:01 INFO - 'NO_EM_RESTART': '1', 11:57:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:57:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:57:01 INFO - 'PWD': '/builds/slave/test', 11:57:01 INFO - 'SHELL': '/bin/bash', 11:57:01 INFO - 'SHLVL': '1', 11:57:01 INFO - 'TERM': 'linux', 11:57:01 INFO - 'TMOUT': '86400', 11:57:01 INFO - 'USER': 'cltbld', 11:57:01 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1491071570.662924-91094382', 11:57:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:57:01 INFO - '_': '/tools/buildbot/bin/python'} 11:57:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:57:01 INFO - Running setup.py (path:/tmp/pip-HwMr0X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:57:01 INFO - Running setup.py (path:/tmp/pip-vYjO5X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:57:01 INFO - Running setup.py (path:/tmp/pip-JZ0Pbb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:57:01 INFO - Running setup.py (path:/tmp/pip-KqWZuG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:57:01 INFO - Running setup.py (path:/tmp/pip-Zb6naS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:57:01 INFO - Running setup.py (path:/tmp/pip-awJ1HQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:57:01 INFO - Running setup.py (path:/tmp/pip-jC22_n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:57:01 INFO - Running setup.py (path:/tmp/pip-QkhjX2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:57:01 INFO - Running setup.py (path:/tmp/pip-HiA5nt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:57:01 INFO - Running setup.py (path:/tmp/pip-yVQuJl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:57:02 INFO - Running setup.py (path:/tmp/pip-20dmAJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:57:02 INFO - Running setup.py (path:/tmp/pip-21mabZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:57:02 INFO - Running setup.py (path:/tmp/pip-p4Jgj1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:57:02 INFO - Running setup.py (path:/tmp/pip-PtcBx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:57:02 INFO - Running setup.py (path:/tmp/pip-bpqiAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:57:02 INFO - Running setup.py (path:/tmp/pip-iF7FEY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:57:02 INFO - Running setup.py (path:/tmp/pip-gl6awl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:57:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:57:02 INFO - Running setup.py install for manifestparser 11:57:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:57:02 INFO - Running setup.py install for mozcrash 11:57:02 INFO - Running setup.py install for mozdebug 11:57:02 INFO - Running setup.py install for mozdevice 11:57:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:57:02 INFO - Running setup.py install for mozfile 11:57:03 INFO - Running setup.py install for mozhttpd 11:57:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:57:03 INFO - Running setup.py install for mozinfo 11:57:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:57:03 INFO - Running setup.py install for mozInstall 11:57:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:57:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:57:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:57:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:57:03 INFO - Running setup.py install for mozleak 11:57:03 INFO - Running setup.py install for mozlog 11:57:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:57:03 INFO - Running setup.py install for moznetwork 11:57:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:57:03 INFO - Running setup.py install for mozprocess 11:57:03 INFO - Running setup.py install for mozprofile 11:57:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:57:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:57:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:57:03 INFO - Running setup.py install for mozrunner 11:57:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:57:04 INFO - Running setup.py install for mozscreenshot 11:57:04 INFO - Running setup.py install for moztest 11:57:04 INFO - Running setup.py install for mozversion 11:57:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:57:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:57:04 INFO - Cleaning up... 11:57:04 INFO - Return code: 0 11:57:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:57:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:57:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:57:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:57:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:57:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:57:04 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 0x270d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ab310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a8400>, '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 0x29a93b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29a9840>, '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-1491071570.662924-91094382', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:57:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:57:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:57:04 INFO - Using env: {'DISPLAY': ':0', 11:57:04 INFO - 'HOME': '/home/cltbld', 11:57:04 INFO - 'LANG': 'en_US.UTF-8', 11:57:04 INFO - 'LANGUAGE': 'en_US:en', 11:57:04 INFO - 'LOGNAME': 'cltbld', 11:57:04 INFO - 'MAIL': '/var/mail/cltbld', 11:57:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:57:04 INFO - 'MOZ_NO_REMOTE': '1', 11:57:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:57:04 INFO - 'NO_EM_RESTART': '1', 11:57:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:57:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:57:04 INFO - 'PWD': '/builds/slave/test', 11:57:04 INFO - 'SHELL': '/bin/bash', 11:57:04 INFO - 'SHLVL': '1', 11:57:04 INFO - 'TERM': 'linux', 11:57:04 INFO - 'TMOUT': '86400', 11:57:04 INFO - 'USER': 'cltbld', 11:57:04 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1491071570.662924-91094382', 11:57:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:57:04 INFO - '_': '/tools/buildbot/bin/python'} 11:57:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:57:04 INFO - Running setup.py (path:/tmp/pip-YiYcjj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:57:04 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:57:04 INFO - Running setup.py (path:/tmp/pip-C0ujcL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:57:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:57:04 INFO - Running setup.py (path:/tmp/pip-pLMYNW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:57:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:57:04 INFO - Running setup.py (path:/tmp/pip-y7jENc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:57:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:57:04 INFO - Running setup.py (path:/tmp/pip-bMYnUt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:57:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:57:04 INFO - Running setup.py (path:/tmp/pip-zwsZtD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:57:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:57:04 INFO - Running setup.py (path:/tmp/pip-JQ_em7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:57:05 INFO - Running setup.py (path:/tmp/pip-pg2VBm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:57:05 INFO - Running setup.py (path:/tmp/pip-UPKRXi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:57:05 INFO - Running setup.py (path:/tmp/pip-dTFPsW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:57:05 INFO - Running setup.py (path:/tmp/pip-tqpi5H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:57:05 INFO - Running setup.py (path:/tmp/pip-PAu9A9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:57:05 INFO - Running setup.py (path:/tmp/pip-7Ibn2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:57:05 INFO - Running setup.py (path:/tmp/pip-MofkJT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:57:05 INFO - Running setup.py (path:/tmp/pip-AHrd9V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:57:05 INFO - Running setup.py (path:/tmp/pip-aL4P5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:57:05 INFO - Running setup.py (path:/tmp/pip-9UEF8T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:57:05 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:57:05 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:57:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:57:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:57:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:57:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:57:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:57:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:57:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:57:07 INFO - Downloading blessings-1.6.tar.gz 11:57:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:57:07 INFO - Installing collected packages: blessings 11:57:07 INFO - Running setup.py install for blessings 11:57:08 INFO - Successfully installed blessings 11:57:08 INFO - Cleaning up... 11:57:08 INFO - Return code: 0 11:57:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:57:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:57:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:57:08 INFO - Reading from file tmpfile_stdout 11:57:08 INFO - Current package versions: 11:57:08 INFO - argparse == 1.2.1 11:57:08 INFO - blessings == 1.6 11:57:08 INFO - blobuploader == 1.2.4 11:57:08 INFO - docopt == 0.6.1 11:57:08 INFO - functools32 == 3.2.3-2 11:57:08 INFO - jsonschema == 2.5.1 11:57:08 INFO - manifestparser == 1.1 11:57:08 INFO - mozInstall == 1.12 11:57:08 INFO - mozcrash == 1.0 11:57:08 INFO - mozdebug == 0.1 11:57:08 INFO - mozdevice == 0.49 11:57:08 INFO - mozfile == 1.2 11:57:08 INFO - mozhttpd == 0.7 11:57:08 INFO - mozinfo == 0.9 11:57:08 INFO - mozleak == 0.1 11:57:08 INFO - mozlog == 3.4 11:57:08 INFO - moznetwork == 0.27 11:57:08 INFO - mozprocess == 0.25 11:57:08 INFO - mozprofile == 0.28 11:57:08 INFO - mozrunner == 6.13 11:57:08 INFO - mozscreenshot == 0.1 11:57:08 INFO - mozsystemmonitor == 0.3 11:57:08 INFO - moztest == 0.8 11:57:08 INFO - mozversion == 1.4 11:57:08 INFO - psutil == 3.1.1 11:57:08 INFO - requests == 1.2.3 11:57:08 INFO - wsgiref == 0.1.2 11:57:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:57:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:57:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:57:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:57:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:57:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:57:08 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 0x270d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ab310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a8400>, '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 0x29a93b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29a9840>, '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-1491071570.662924-91094382', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:57:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:57:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:57:08 INFO - Using env: {'DISPLAY': ':0', 11:57:08 INFO - 'HOME': '/home/cltbld', 11:57:08 INFO - 'LANG': 'en_US.UTF-8', 11:57:08 INFO - 'LANGUAGE': 'en_US:en', 11:57:08 INFO - 'LOGNAME': 'cltbld', 11:57:08 INFO - 'MAIL': '/var/mail/cltbld', 11:57:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:57:08 INFO - 'MOZ_NO_REMOTE': '1', 11:57:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:57:08 INFO - 'NO_EM_RESTART': '1', 11:57:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:57:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:57:08 INFO - 'PWD': '/builds/slave/test', 11:57:08 INFO - 'SHELL': '/bin/bash', 11:57:08 INFO - 'SHLVL': '1', 11:57:08 INFO - 'TERM': 'linux', 11:57:08 INFO - 'TMOUT': '86400', 11:57:08 INFO - 'USER': 'cltbld', 11:57:08 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1491071570.662924-91094382', 11:57:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:57:08 INFO - '_': '/tools/buildbot/bin/python'} 11:57:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:57:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:57:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:57:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:57:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:57:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:57:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:57:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:57:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:57:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:57:08 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:57:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:57:08 INFO - Cleaning up... 11:57:08 INFO - Return code: 0 11:57:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:57:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:57:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:57:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:57:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:57:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:57:08 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 0x270d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ab310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a8400>, '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 0x29a93b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29a9840>, '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-1491071570.662924-91094382', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:57:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:57:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:57:08 INFO - Using env: {'DISPLAY': ':0', 11:57:08 INFO - 'HOME': '/home/cltbld', 11:57:08 INFO - 'LANG': 'en_US.UTF-8', 11:57:08 INFO - 'LANGUAGE': 'en_US:en', 11:57:08 INFO - 'LOGNAME': 'cltbld', 11:57:08 INFO - 'MAIL': '/var/mail/cltbld', 11:57:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:57:08 INFO - 'MOZ_NO_REMOTE': '1', 11:57:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:57:08 INFO - 'NO_EM_RESTART': '1', 11:57:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:57:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:57:08 INFO - 'PWD': '/builds/slave/test', 11:57:08 INFO - 'SHELL': '/bin/bash', 11:57:08 INFO - 'SHLVL': '1', 11:57:08 INFO - 'TERM': 'linux', 11:57:08 INFO - 'TMOUT': '86400', 11:57:08 INFO - 'USER': 'cltbld', 11:57:08 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1491071570.662924-91094382', 11:57:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:57:08 INFO - '_': '/tools/buildbot/bin/python'} 11:57:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:57:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:57:08 INFO - Cleaning up... 11:57:08 INFO - Return code: 0 11:57:08 INFO - Running post-action listener: _resource_record_post_action 11:57:08 INFO - Running post-action listener: _start_resource_monitoring 11:57:08 INFO - Starting resource monitoring. 11:57:08 INFO - [mozharness: 2017-04-01 18:57:08.801624Z] Finished create-virtualenv step (success) 11:57:08 INFO - [mozharness: 2017-04-01 18:57:08.802083Z] Running install step. 11:57:08 INFO - Running pre-action listener: _resource_record_pre_action 11:57:08 INFO - Running main action method: install 11:57:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:57:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:57:09 INFO - Reading from file tmpfile_stdout 11:57:09 INFO - Detecting whether we're running mozinstall >=1.0... 11:57:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:57:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:57:09 INFO - Reading from file tmpfile_stdout 11:57:09 INFO - Output received: 11:57:09 INFO - Usage: mozinstall [options] installer 11:57:09 INFO - Options: 11:57:09 INFO - -h, --help show this help message and exit 11:57:09 INFO - -d DEST, --destination=DEST 11:57:09 INFO - Directory to install application into. [default: 11:57:09 INFO - "/builds/slave/test"] 11:57:09 INFO - --app=APP Application being installed. [default: firefox] 11:57:09 INFO - mkdir: /builds/slave/test/build/application 11:57:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:57:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:57:25 INFO - Reading from file tmpfile_stdout 11:57:25 INFO - Output received: 11:57:25 INFO - /builds/slave/test/build/application/firefox/firefox 11:57:25 INFO - Running post-action listener: _resource_record_post_action 11:57:25 INFO - [mozharness: 2017-04-01 18:57:25.946725Z] Finished install step (success) 11:57:25 INFO - [mozharness: 2017-04-01 18:57:25.946873Z] Running run-tests step. 11:57:25 INFO - Running pre-action listener: _resource_record_pre_action 11:57:25 INFO - Running main action method: run_tests 11:57:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:57:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:57:25 INFO - Python 2.7.3 11:57:25 INFO - Return code: 0 11:57:25 INFO - grabbing minidump binary from tooltool 11:57:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:57:25 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 0x29a8400>, '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 0x29a93b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29a9840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:57:25 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:57:25 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:57:25 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:57:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:57:26 INFO - Return code: 0 11:57:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:57:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:57:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:57:26 INFO - ENV: RUST_BACKTRACE is now 1 11:57:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:57:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:57:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Nzt4cWyVR9CwgazV4zVRow/artifacts/public/build/target.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 11:57:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Nzt4cWyVR9CwgazV4zVRow/artifacts/public/build/target.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 11:57:26 INFO - Using env: {'DISPLAY': ':0', 11:57:26 INFO - 'HOME': '/home/cltbld', 11:57:26 INFO - 'LANG': 'en_US.UTF-8', 11:57:26 INFO - 'LANGUAGE': 'en_US:en', 11:57:26 INFO - 'LOGNAME': 'cltbld', 11:57:26 INFO - 'MAIL': '/var/mail/cltbld', 11:57:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:57:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:57:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:57:26 INFO - 'MOZ_NO_REMOTE': '1', 11:57:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:57:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:57:26 INFO - 'NO_EM_RESTART': '1', 11:57:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:57:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:57:26 INFO - 'PWD': '/builds/slave/test', 11:57:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:57:26 INFO - 'RUST_BACKTRACE': '1', 11:57:26 INFO - 'SHELL': '/bin/bash', 11:57:26 INFO - 'SHLVL': '1', 11:57:26 INFO - 'TERM': 'linux', 11:57:26 INFO - 'TMOUT': '86400', 11:57:26 INFO - 'USER': 'cltbld', 11:57:26 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1491071570.662924-91094382', 11:57:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:57:26 INFO - '_': '/tools/buildbot/bin/python'} 11:57:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Nzt4cWyVR9CwgazV4zVRow/artifacts/public/build/target.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 11:57:26 INFO - mozversion application_buildid: 20170401171348 11:57:26 INFO - mozversion application_changeset: 7a3f514cf8490d271ee373a1d2999e4ea4dee2d7 11:57:26 INFO - mozversion application_display_name: Nightly 11:57:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:57:26 INFO - mozversion application_name: Firefox 11:57:26 INFO - mozversion application_remotingname: firefox 11:57:26 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:57:26 INFO - mozversion application_vendor: Mozilla 11:57:26 INFO - mozversion application_version: 55.0a1 11:57:26 INFO - mozversion platform_buildid: 20170401171348 11:57:26 INFO - mozversion platform_changeset: 7a3f514cf8490d271ee373a1d2999e4ea4dee2d7 11:57:26 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:57:26 INFO - mozversion platform_version: 55.0a1 11:57:26 INFO - using testdate: 1491073046 11:57:26 INFO - actual date: 1491073046 11:57:26 INFO - starting webserver on 'localhost:36702' 11:57:26 INFO - SUITE-START | Running 2 tests 11:57:26 INFO - TEST-START | dromaeo_css 11:57:26 INFO - operating with platform_type : linux_ 11:57:26 INFO - Initialising browser for dromaeo_css test... 11:57:26 INFO - TEST-INFO | started process 3316 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAmArOi/profile http://localhost:36702/getInfo.html) 11:57:31 INFO - PID 3316 | __metrics Screen width/height:1600/1200 11:57:31 INFO - PID 3316 | colorDepth:24 11:57:31 INFO - PID 3316 | Browser inner width/height: 1024/697 11:57:31 INFO - PID 3316 | __metrics 11:57:32 INFO - PID 3316 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:57:32 INFO - PID 3316 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:57:33 INFO - TEST-INFO | 3316: exit 0 11:57:33 INFO - Browser initialized. 11:57:33 INFO - Running cycle 1/1 for dromaeo_css test... 11:57:33 INFO - TEST-INFO | started process 3412 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAmArOi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:57:45 INFO - PID 3412 | RSS: Main: 144191488 11:57:45 INFO - PID 3412 | 12:00:48 INFO - PID 3412 | Cycle 1(1): loaded http://localhost:36702/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36702/tests/dromaeo/cssquery-ext.html) 12:00:49 INFO - PID 3412 | RSS: Main: 259313664 12:00:49 INFO - PID 3412 | 12:02:35 INFO - PID 3412 | ************************* 12:02:35 INFO - PID 3412 | A coding exception was thrown and uncaught in a Task. 12:02:35 INFO - PID 3412 | 12:02:35 ERROR - PID 3412 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:02:35 INFO - PID 3412 | Full stack: 12:02:35 INFO - PID 3412 | ************************* 12:02:35 INFO - PID 3412 | ************************* 12:02:35 INFO - PID 3412 | A coding exception was thrown and uncaught in a Task. 12:02:35 INFO - PID 3412 | 12:02:35 ERROR - PID 3412 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:02:35 INFO - PID 3412 | Full stack: 12:02:35 INFO - PID 3412 | ************************* 12:02:35 INFO - PID 3412 | ************************* 12:02:35 INFO - PID 3412 | A coding exception was thrown and uncaught in a Task. 12:02:35 INFO - PID 3412 | 12:02:35 ERROR - PID 3412 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:02:35 INFO - PID 3412 | Full stack: 12:02:35 INFO - PID 3412 | ************************* 12:02:35 INFO - PID 3412 | ************************* 12:02:35 INFO - PID 3412 | A coding exception was thrown and uncaught in a Task. 12:02:35 INFO - PID 3412 | 12:02:35 ERROR - PID 3412 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:02:35 INFO - PID 3412 | Full stack: 12:02:35 INFO - PID 3412 | ************************* 12:03:51 INFO - PID 3412 | Cycle 1(1): loaded http://localhost:36702/tests/dromaeo/cssquery-ext.html (next: http://localhost:36702/tests/dromaeo/cssquery-jquery.html) 12:03:52 INFO - PID 3412 | RSS: Main: 229515264 12:03:52 INFO - PID 3412 | 12:06:54 INFO - PID 3412 | Cycle 1(1): loaded http://localhost:36702/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36702/tests/dromaeo/cssquery-mootools.html) 12:06:54 INFO - PID 3412 | RSS: Main: 177270784 12:06:54 INFO - PID 3412 | 12:09:56 INFO - PID 3412 | Cycle 1(1): loaded http://localhost:36702/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36702/tests/dromaeo/cssquery-prototype.html) 12:09:57 INFO - PID 3412 | RSS: Main: 177266688 12:09:57 INFO - PID 3412 | 12:13:00 INFO - PID 3412 | Cycle 1(1): loaded http://localhost:36702/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36702/tests/dromaeo/cssquery-yui.html) 12:13:00 INFO - PID 3412 | RSS: Main: 181723136 12:13:00 INFO - PID 3412 | 12:16:03 INFO - PID 3412 | Cycle 1(1): loaded http://localhost:36702/tests/dromaeo/cssquery-yui.html (next: http://localhost:36702/tests/dromaeo/cssquery-dojo.html) 12:16:03 INFO - PID 3412 | RSS: Main: 271564800 12:16:03 INFO - PID 3412 | 12:16:03 INFO - PID 3412 | __start_tp_report 12:16:03 INFO - PID 3412 | _x_x_mozilla_page_load 12:16:03 INFO - PID 3412 | _x_x_mozilla_page_load_details 12:16:03 INFO - PID 3412 | |i|pagename|runs| 12:16:03 INFO - PID 3412 | |0;dojo.html;3318.3695097931395;3343.7325013998866;3370.966290337096;3375.5780527434063;3398.0825177202155;5670.4896559309655;5699.116636921273;5836.299644042716;5841.912371314434;5846.736896839642;5699.515541178995;5728.140778883169;5740.5981581289325;5740.885182296352;5743.54051675866;5085.059264036166;5091.770870310845;5158.92261616076;5202.583793296546;5228.607854410934;5225.581953443734;5228.869278268055;5229.581633469314;5236.240745091959;5282;690.4320773932469;5124.052050370693;5230.633855630107;5246.68519888806;5291.2327712481665;5107.029664363796;5125.026245013435;5152.278680984665;5209.296744939423;5214.947850521484;5133.460986596391;5140.203268493389;5145.588352931794;5145.716985565792;5188.403333616645;5678.063119585264;5745.770169193227;5771;5775.047117225653;5825.533957283407;6150;6151.815445536641;6240.282367527701;6284.905726414062;6317.084022816712;6333.429991300805;6378.075179099051;6392.105105285264;6394.840128996766;6394.912864812993;5921.526277897758;5929.407059294036;5930.347661757203;5931.228940237785;5934.910976335358;6272.905906411407;6287.528435367274;6417.711202995783;6485.578437401554;6505.60966342021;6220.129181914535;6225.28409232944;6232.657203853832;6233.470155036782;6235.532335074888;6105.831093534924;6281.3404592518045;6323.494120470444;6329.588576742497;6333.68331583419;6078.179445774852;6170.167027451326;6177.042558403455;6205.565610407228;6265.65538895356;6255.374462553799;6261.060840873814;6263.812085637438;6268.874622507525;6273.592216505913;4771.785269662873;4778.832740854054;4785.186518291899;4785.306130611042;4824.734639594856;4185.518665353462;4217.072244106292;4239.682023848224;4285.121550082225;4290.099079193405;5935.821925342247;5944.346121926585;5955.076963070731;5956.434138756811;5994.310654274727;6250.499960003189;6258.186435763321;6315.747370105236;6326.082718005863;6331.4301712845145;5827.184194212814;5899.675517846474;5948;5971.820845374646;6048.788292409832;5349.144136938071;5352.678839269656;5367.114426119724;5387.24578559002;5417.485338892799;6609.339066093352;6619.768308109096;6619.768308109193;6627.966860165861;6630.403263706289;6095.529019716752;6121.452973575903;6241.282252541016;6348.301686814539;6349.301576826453;6469.126667899962;6513.185851768529;6545.803625891231;6550.8362290943105;6560.9343906562235;6204.565680402509;6209.161763161916;6211.3478084802255;6212.161358216583;6247.781327653692;6094.75620975156;6119.868162944114;6268.592541484789;6305.495560355253;6326.335734747785;6103.389661034039;6119.959572021022;6122.550631083031;6125.052321062068;6131.651934473353;6098.825584107018;6108.8778224436155;6115.483736156635;6116.0010150213275;6116.944513560587;5954.493868021266;5955.5235581154275;6001.2498437695285;6048.092786082123;6092.390760923872;6131.693415329305;6157.599756015845;6181.721822517908;6187.752489900354;6201.1628430163155;5989.610675306091;6000.399960004139;6001.729922153426;6002.459778619946;6017.458428741435 12:16:03 INFO - PID 3412 | |1;ext.html;751.8233215194429;806.4234072638062;820.1306614988112;1141.6403832792664;1160.2980196980832;31909;40031.79984100079;40199.79900100503;40378;40499;43714.78142609291;44026;44053;44099;44119.33820992688;6270;6428.453581445559;8214.096449390563;8362.080171181165;8363.665453381887;8146.551939643317;8366;8374.371922105867;8375.95812020939;8383.035950865637;8423.157684231559;8501.489910605353;8506.36202284828;8507.659693612279;8548.78628034301;8386.287165590933;8470.534120623362;8471.279941204974;8493.74518764432;8494.660213591449;8296.70961516344;8335;8345.707900223524;8365;8366.53984030878;41755;41865.581344186474;41889.79055104736;41975.580244197474;42107.57892421067;2900.9274768130754;2910.3015276333526;2912.89804856829;2934.105097945126;2947.5283954567167;27862.442751145067;27987.720122798713;28089.43821123566;28154.859225703945;28221.15336539907;3576.6065732769375;3582.6417358264225;3607.188382613891;3644;3672.375696131664;192956;193335;193401;193480.9999999986;194358;48804.947183715;49306;49385.259221111715;49454.258186127234;49472.50527494679;50458.747706261966;50910.74544627253;51140;51142;51213.74393128085;15438.382464701286;15523.223838808015;15525.922370388076;15548;15548.533543993699;10544.261901666963;10721.946390268155;12274.140810143383;12404.62786116418;12442.440090195963;14737.336819843133;14748.115113093249;14903.254837258311;14913.403463861541;15044.924775376054;5817.7963771267805;5821.825345239565;5886.381929897385;5903.0224874667465;5983.252093488314;1060.3955745225148;1062.9362238265728;1065.8507808906604;1073.1629329123296;1097.1332647208617;26235;26405.47189056208;26703.46593068128;26924.730752692223;26966.865165674048;1149.4252873563219;1168.9649310520697;1170.8068168752231;1172.9178957472895;1217.7503611759569;13983.161010339412;14034.578962631138;14175.85824141766;14238.644033899029;14284;307178;310340;310382;310408;364187;61507.38492615017;61543.38456615466;62061.37938620556;62307;62353.37646623566;1445.9855401446061;1476.645605054779;1479.186447453896;1487.9256037198097;1497.827749808786;29456.852715737143;31329.68670313359;31372.686273136977;31700.207494811893;31775.36449271048;42012.789936050125;52570.73714631402;53522.73238633782;53532.73233633807;53570;337553;341115;341429;345156;345907;28061.71938280591;28566;28590.571141433313;36553.45169822402;36857.26285474329;36688.816555918114;42623.57376426196;43490.782546087066;43735.34396984112;44741.32888006748;32843.34313313768;32889.34221315608;33160.336793263516;33213.33573328568;33309.83345083259;32201.51697724489;32788.34423311472;33026.66973330236;33160.834195828866;33876.83061584676;38186.42720359141;39187.216255675296;39209.803950980066;39257.41113883237;39288.6071139285;32873.34253314872;33107.337853242316;33256;33368;33791.662083378855;26565.22238364102;27458.17625471239;27463.588046179724;27557.244275572284;27865.58201627018 12:16:03 INFO - PID 3412 | |2;jquery.html;378.55519764276966;449.2183600535068;449.64702708373915;462.76167773596603;462.94444666640004;19933.900330498345;20759;21464.463388415257;21508.677369839425;21658.566828663435;22969.770302296973;23190.536189276205;23360.415989600267;23569.29292121235;23642;6124.663143527104;6162.383761623835;6165.907511387333;6224.968875155618;6284.214473190851;6150.938490615104;6216.751329946819;6226.844328891769;6236.906446403307;6252.09311160096;6056.636601803906;6150.815475535741;6155.630662160284;6162.383761623824;6185.969070154665;5919.1713160157615;6149.723262453201;6173.32093469718;6189.350118237565;6196.81409557714;5494.862628434281;5533.557315414757;5538;5539.446055394428;5541.196526503634;26285.21144365672;26336.34159146037;26768;27139.592906106423;27326;2012.748406449194;2042.867213631124;2044.2640649366217;2050.29264903608;2070.3995841206033;16344.591385215346;16429.58926026847;16851.157442127846;16886.493405197863;17302.480925572254;2104.736907886514;2108.3674897530677;2113.6406810842195;2154.1706443019552;2168.0894024509744;107103;110832.9999999992;111190.44404778005;111386.44306778496;111730.44134779274;11476.770464590662;12285.262884226975;12589.370531473389;12640.810387844189;12844.357782110857;16147.596310092107;16514.42199523011;16547.917260413862;16559.25483353228;16592.917035414746;8928.330375221754;8946.194842464209;9204.907950920538;9297.581608827619;9307.581158847868;8553.315734741205;8562.229399354088;8642.22220000203;8907.465552066897;8912.108789121035;7780.961095194488;7878;7990.280874721187;8022.79943001418;8064.637091330904;2206.1837120265604;2241.5853067182625;2263.445455863291;2265.4902646904316;2421.418859473749;985.4186030242191;995.746084748399;998.9550470228858;1005.2209537608265;1022.4529876516028;20572.177112915317;20850.58298834045;20964.580708386053;21131.577368452545;21222.75544891028;1000.3997601439224;1031.437866362834;1037.6886933919793;1057.2282233969245;1067.4662668665667;10408.323458975143;11224;11251.381174035507;11291.717707057389;11292.096632269398;644306;656643;667105;677542;679685;114525.4273728626;115568;116627.41686291514;116640.41679791547;118755;1217.190568272107;1232.5439587352557;1265.1586694848006;1268.2770820632336;1268.898488120948;16211.675766484841;16584.50246492607;17124.571885702957;17187.398441055004;17551.82448175502;51525;53309.46690533045;53929.99999999843;54003.72998134984;54171;63557;64248.67875660592;65097;66369.66815165893;68580.6570967142;9310.534473276173;9617.807643847224;9633.566489507848;9720.805583888141;10106.39361638304;15291;15413.306401211748;15498.690026199187;15508.612284692974;16093;12253.632391028283;12932.547360842325;13076;13092.738145236852;13230.82460209562;12336.81494777561;12355.505779768708;12393.62819115428;12485.375731213584;12990.805137922749;12720.04599655011;12884.549040783902;13176.341182941007;13288.800667990181;13553.728925421634;9128.543572821465;9355.391899526508;9642.807143857224;9675.806483870423;10019.799604007732;11978.820317695066;12403;12872.034597405045;13040;13336.266505342299 12:16:03 INFO - PID 3412 | |3;mootools.html;1301.1867582760774;1332.793417020362;1345.9192448453086;1356.4302992743046;1365.5015919189498;10332.276740628158;10655.147588192945;10732.570697172103;10736.677899663004;10755.300905441141;10509.84235236472;10792.946035269832;11000.614978475754;11014.39420831854;11030.889691103086;2292.564412761574;2355.8233132515043;2358.905643774247;2361.527694461106;2361.551305252005;1998.450426132818;2227.487677834099;2292.037344315383;2373.050779688121;2376.786089251967;2058.557410156816;2267.9886600566974;2343.60158773009;2346.6480027995767;2351.670766092748;2256.108837009372;2299.2642354446584;2308.976910230893;2310.06442390832;2313.4332088638225;2145.452909508081;2150.1184514349043;2156.1590979518;2158.665406861939;2159.4169574214875;10555.788884222273;10637.57449702011;10644.840327395095;10649.307794993378;10668.679939601825;5943.910841337383;6109.5723299369065;6141.785037523665;6144.815655530341;6151.6001459904965;3416.180116771982;3471.513988041651;3709.7403181777286;3780.111673756665;3790.014596204979;1294.5792617399288;1306.6798634334555;1322.5187789675529;1343.6909510812568;1373.4849431463201;15405.460808871749;15786.842131578653;15786.842131578653;15791.210439478094;15796.526104216891;5192.792288308501;5420.430854760193;5453.563714902798;5500.944990550043;5565.16522521625;12954.481820727255;12963.092583519252;12981.41583628739;13001.024923130803;13007.284599346938;6328.145700330489;6329;6334.588251763621;6336.17629708135;6341.4609758170145;5534.418886016991;5547.362053363834;5567.66594004361;5575.080111781592;5579.776808927679;4394.714343567658;4458.977705111453;4494.887627809331;4499.370088187657;4512.210363186429;1175.9647210583696;1319.663485811112;1346.1451977994045;1348.548236340817;1349.1702602899343;707.2008630247788;810.8337790752881;823.0945959444563;836.9790755231046;838.8951381077366;5731.742071606787;5735.913961290584;5746.511546518593;5797.623154494944;6045.939540604538;937.2174234514257;952.7237101240701;957.4255446731905;968.4431451915177;971.7182017214928;3648.6351364863303;3658.9634103659155;3664.72514561409;3665.4318580620047;3752.605976372496;13109.213447193199;13621.84214341792;13692.863071369358;13699.794503082461;13725.313734313444;12940.223586584834;13499.055066145276;13542.796858047137;13550.322483875767;13568.389422476012;10049.346792458467;10280.588776448858;10282.434466104436;10291.33106348085;10301.227407944285;6463.482921366373;6671.766488172891;6697.162854643169;6701.8324541884895;6715.462762978852;12285.631431057083;12616.49534018629;12627.558035468715;12638.43127059303;12658.11393202467;12586.748265034832;12771.872281277068;12800.935995319964;12833;12872.22766634005;8967.372283940062;9165.679201227926;9258.444493330422;9259.629614815602;9263;10022.548985295532;10084;10088.949555252177;10221.33561318512;10234.948825255826;7286.781396558112;8152.673893044212;8677.652893884426;8770.561471926505;8955.238804701674;8342.249197572248;8563;8604.827903442021;8730.301575874042;8808.5595720215;7085.645717713991;7109.928900711134;7160;7174.964125179341;7232.783016509513;5549.500544950974;5554.1946417770005;5630.071038278638;5659.830205093854;5837.883242335045;5650.491455769001;5660.122680984454;5753.942460575341;5773.220615216892;5818.6217895836635 12:16:03 INFO - PID 3412 | |4;prototype.html;413.7806962309976;414.7615121305249;430.8996768252425;431.39389158232694;438.46069334718294;5795.3335366432875;5994.610350327226;6012.639241645499;6015.278166620006;6024.186734790813;5791.420857914207;5911.763529458827;5926.585139040269;5932.1991531143285;5939.198208241886;4405.6475481961525;4497.865064048084;4509.751963641998;4509.954900450986;4537.551460889731;4503.301988191819;4508.211063063967;4520.660950428714;4526.864194074183;4538.523455037223;4498.50516443191;4503.977480112595;4510.436195475566;4514.638828893697;4526.8868278292975;4428;4462.4645042594775;4482.843100491467;4491.6182124519455;4497.775111244441;3934.960650393488;3936.7441116327345;3943.6056394360335;3947.782871942042;3960.5643379228263;5707.6290041147195;5760.279965004374;5768.673205162794;5775.1337299405;5786.1610066540115;5183.792648294064;5228.588281164064;5259.316288882421;5316.707581083039;5319;6221.657808820513;6247.812565623039;6264.843378915563;6272.874542509125;6280.466160376373;4348;4411.228035093878;4459.175052615245;4474.709143905636;4481.574250446235;6220.205674538528;6365.777197798101;6429.742810287583;6498.155239818793;6563.671816409208;4505.7296562206375;4549.727016379028;4554.817807287672;4557.863264102082;4579.793909274091;4625.236835922103;4632.513586073481;4635.976820115878;4648.907021859612;4652.092841895797;4965.404151501771;4974.1543937530705;5272.367315922037;5293.12663410533;5302.92045619316;6179.3202747697715;6228.595141315891;6233.844153896098;6244.875922333933;6281.152044473937;1581.1145758375346;1586.9764002218506;1598.057146283698;1598.7362085256036;1599.2483532739593;1057.8571892794528;1069.647016484574;1084.9403282819362;1089.2647462962627;1100.757833276678;5979.372165922602;6004.849878753066;6025.698715064229;6027.819165425044;6056.727447264883;6311.179546658905;6416.807495775134;6419.165508483868;6425.935740642627;6445.388652836791;5968.970155149196;5992.850178745479;6002.429769171922;6027.397260274025;6046.183765191643;3351.111955331839;3378.408778463808;3387.7289816814596;3387.9497355819776;3399.320135972766;6486.772962946368;6587.53887227899;6611;6622.735090596419;6624.8343791405605;6512.641804700692;6527.2167339919515;6549.705263263165;6568.638724870178;6599.439047681001;6372.852886480386;6701.463882889455;6708.463322934153;6715.4291885190305;6715.999999999903;6424;6434.935650643433;6439.871202576016;6443.903341449975;6449.451796597342;6179.76404719067;6370.649614271259;6378.596708724073;6397.648129352744;6406.231252249573;6459.289478157493;6557.704903279268;6572.704228309642;6663.233728121328;6732.124823772878;4546.61353784932;4549.79525921341;4569.1547063793305;4576.954230457653;4589.816407343669;6335.809925702236;6470.741170353133;6523.412892839668;6531.608103513804;6538.738450462119;6259.6870156492905;6273.341299163522;6275.152854364603;6299.433051025429;6309.747610095545;6221.96889015552;6257.937420625735;6258.3741625838875;6262.4990000800735;6272.310045894857;6058.787942421994;6191.628502289877;6191.659458729813;6211.0372892201785;6223.408776166257;6272.749090036347;6311.2426508819235;6320.936790632035;6338.176037115146;6339.639990804881;5840.503557197686;6043.214382130295;6071.089336599545;6157.4298553868475;6181.660008699385 12:16:03 INFO - PID 3412 | |5;yui.html;752.2890868129618;754.0611938137021;755.2636179724769;758.6965213914433;772.8029352515111;15646.84353156468;16185.83814161858;16196.75704864428;16205.83794162058;16209.189540522972;13306.06857519974;13317.334133293345;13318.866811331884;13325.067245292834;13336.866631333683;910.3627460777449;920.22241206181;951.0727041134872;955.4267439536258;961.4279503695325;969.3505351414569;970.611755297883;973.6446197138065;973.9561719722594;974.2157563161652;1018.3940555369543;1021.1881554164457;1021.325924889573;1021.366752613377;1021.6322124035379;1003.9447830369327;1006.7281833904841;1006.9446180460071;1009.8838633557161;1011.7015480433253;736.7826491185114;741.929516695913;745.0723848808215;745.1803016681661;745.8508298340354;15416;15474.45839395627;15689.137097459636;17091.14544272794;17328.826711732847;15275.923620381827;15551.533453996399;15696.686066278611;15859.762103568455;16133.596660083474;12186.146969712123;12252;12407.689807754788;12882.549110781172;13378.531751388751;3166.335069635379;3210.5184222366597;3241.6110066792135;3256.690614391629;3291;81406;82914.17085829064;83684.58157709173;89791.55104224502;95843;12021.218620789796;12210.633680989584;12300;12356.196847204903;12478.500859965681;24804.255872323858;25310.367240819127;25726.74273257281;25779;26013.219603411548;7760.650770715331;7766.728164514328;7864.921350786533;7896.210378962172;8159.26566609008;3987.8205480753436;4045.959540404558;4053.7365071270274;4054.412110244057;4068.7762173080764;4345.196138714348;4412.271975124133;4421.557844215553;4474.664400169935;4490.124425737015;819.3445243804932;819.4059307002376;825.145973917005;838.1199740272689;854.6239654551978;614.4961131871911;625.5433533520555;631.5200447659812;637.6556659403963;662.840918179643;9522.90477095234;10084.899151008543;10112.59549618007;10232.525668579887;10332.896671033344;599.7271241585069;621.4903778901257;622.2408661433044;626.5958456795341;632.8797528469576;4403.625691816232;4472.172648060119;4696.507712280474;4774.809007639656;4812.590929771009;83175.16824831674;84353.57823210968;84375.01558657938;85237.57381213055;85991;48313;48776;52986.20520692193;74497.25502745011;76528;61525;62193;62417.06374404387;63131.684341577995;64665;9042;9536.380135291183;9921.40471571708;9997.250206234707;10059.724617037584;31142.22144446407;31993;32859.67140328566;33233.33533329368;33476.83261583676;53543.46456535385;55172.17241741457;55199.72400138134;55368;56328;11774.705632359259;11843.11176661771;11881.702957425789;11943.641690749291;12176.055951590943;12588.370581471074;12601.382993563358;12752.234865908074;13015.219086854819;13067.411966461343;11553.884461155281;11653.59212427561;11720.70698232551;11765.705857353634;11936.820947685965;11670.591529296435;11698.532058717556;11772.82340764872;11960.282383057045;12421.75156496883;11123.888761112608;11317.377544234816;11478.368689722145;11850.348230847387;12113.757724845278;8631.26634236097;8880.1563851434;9048.366614336934;9096.27229821626;9148.542572871196;8432.747017589481;9242.584083716114;9356.438613682929;9383.530823458936;9465.384749991228 12:16:03 INFO - PID 3412 | __end_tp_report 12:16:03 INFO - PID 3412 | __start_cc_report 12:16:03 INFO - PID 3412 | _x_x_mozilla_cycle_collect,1165 12:16:03 INFO - PID 3412 | __end_cc_report 12:16:03 INFO - PID 3412 | __startTimestamp1491074163635__endTimestamp 12:16:03 INFO - PID 3412 | 12:16:03 INFO - PID 3412 | ------- Summary: start ------- 12:16:03 INFO - PID 3412 | Number of tests: 6 12:16:03 INFO - PID 3412 | 12:16:03 INFO - PID 3412 | [#0] dojo.html Cycles:165 Average:5768.75 Median:6048.79 stddev:796.14 (13.2%) stddev-sans-first:775.03 12:16:03 INFO - PID 3412 | Values: 3318.4 3343.7 3371.0 3375.6 3398.1 5670.5 5699.1 5836.3 5841.9 5846.7 5699.5 5728.1 5740.6 5740.9 5743.5 5085.1 5091.8 5158.9 5202.6 5228.6 5225.6 5228.9 5229.6 5236.2 5282.0 690.4 5124.1 5230.6 5246.7 5291.2 5107.0 5125.0 5152.3 5209.3 5214.9 5133.5 5140.2 5145.6 5145.7 5188.4 5678.1 5745.8 5771.0 5775.0 5825.5 6150.0 6151.8 6240.3 6284.9 6317.1 6333.4 6378.1 6392.1 6394.8 6394.9 5921.5 5929.4 5930.3 5931.2 5934.9 6272.9 6287.5 6417.7 6485.6 6505.6 6220.1 6225.3 6232.7 6233.5 6235.5 6105.8 6281.3 6323.5 6329.6 6333.7 6078.2 6170.2 6177.0 6205.6 6265.7 6255.4 6261.1 6263.8 6268.9 6273.6 4771.8 4778.8 4785.2 4785.3 4824.7 4185.5 4217.1 4239.7 4285.1 4290.1 5935.8 5944.3 5955.1 5956.4 5994.3 6250.5 6258.2 6315.7 6326.1 6331.4 5827.2 5899.7 5948.0 5971.8 6048.8 5349.1 5352.7 5367.1 5387.2 5417.5 6609.3 6619.8 6619.8 6628.0 6630.4 6095.5 6121.5 6241.3 6348.3 6349.3 6469.1 6513.2 6545.8 6550.8 6560.9 6204.6 6209.2 6211.3 6212.2 6247.8 6094.8 6119.9 6268.6 6305.5 6326.3 6103.4 6120.0 6122.6 6125.1 6131.7 6098.8 6108.9 6115.5 6116.0 6116.9 5954.5 5955.5 6001.2 6048.1 6092.4 6131.7 6157.6 6181.7 6187.8 6201.2 5989.6 6000.4 6001.7 6002.5 6017.5 12:16:03 INFO - PID 3412 | 12:16:03 INFO - PID 3412 | [#1] ext.html Cycles:180 Average:45390.67 Median:187495.92 stddev:77015.04 (41.1%) stddev-sans-first:77158.16 12:16:03 INFO - PID 3412 | Values: 751.8 806.4 820.1 1141.6 1160.3 31909.0 40031.8 40199.8 40378.0 40499.0 43714.8 44026.0 44053.0 44099.0 44119.3 6270.0 6428.5 8214.1 8362.1 8363.7 8146.6 8366.0 8374.4 8376.0 8383.0 8423.2 8501.5 8506.4 8507.7 8548.8 8386.3 8470.5 8471.3 8493.7 8494.7 8296.7 8335.0 8345.7 8365.0 8366.5 41755.0 41865.6 41889.8 41975.6 42107.6 2900.9 2910.3 2912.9 2934.1 2947.5 27862.4 27987.7 28089.4 28154.9 28221.2 3576.6 3582.6 3607.2 3644.0 3672.4 192956.0 193335.0 193401.0 193481.0 194358.0 48804.9 49306.0 49385.3 49454.3 49472.5 50458.7 50910.7 51140.0 51142.0 51213.7 15438.4 15523.2 15525.9 15548.0 15548.5 10544.3 10721.9 12274.1 12404.6 12442.4 14737.3 14748.1 14903.3 14913.4 15044.9 5817.8 5821.8 5886.4 5903.0 5983.3 1060.4 1062.9 1065.9 1073.2 1097.1 26235.0 26405.5 26703.5 26924.7 26966.9 1149.4 1169.0 1170.8 1172.9 1217.8 13983.2 14034.6 14175.9 14238.6 14284.0 307178.0 310340.0 310382.0 310408.0 364187.0 61507.4 61543.4 62061.4 62307.0 62353.4 1446.0 1476.6 1479.2 1487.9 1497.8 29456.9 31329.7 31372.7 31700.2 31775.4 42012.8 52570.7 53522.7 53532.7 53570.0 337553.0 341115.0 341429.0 345156.0 345907.0 28061.7 28566.0 28590.6 36553.5 36857.3 36688.8 42623.6 43490.8 43735.3 44741.3 32843.3 32889.3 33160.3 33213.3 33309.8 32201.5 32788.3 33026.7 33160.8 33876.8 38186.4 39187.2 39209.8 39257.4 39288.6 32873.3 33107.3 33256.0 33368.0 33791.7 26565.2 27458.2 27463.6 27557.2 27865.6 12:16:03 INFO - PID 3412 | 12:16:03 INFO - PID 3412 | [#2] jquery.html Cycles:180 Average:36914.45 Median:11831.42 stddev:109735.61 (927.5%) stddev-sans-first:110009.15 12:16:03 INFO - PID 3412 | Values: 378.6 449.2 449.6 462.8 462.9 19933.9 20759.0 21464.5 21508.7 21658.6 22969.8 23190.5 23360.4 23569.3 23642.0 6124.7 6162.4 6165.9 6225.0 6284.2 6150.9 6216.8 6226.8 6236.9 6252.1 6056.6 6150.8 6155.6 6162.4 6186.0 5919.2 6149.7 6173.3 6189.4 6196.8 5494.9 5533.6 5538.0 5539.4 5541.2 26285.2 26336.3 26768.0 27139.6 27326.0 2012.7 2042.9 2044.3 2050.3 2070.4 16344.6 16429.6 16851.2 16886.5 17302.5 2104.7 2108.4 2113.6 2154.2 2168.1 107103.0 110833.0 111190.4 111386.4 111730.4 11476.8 12285.3 12589.4 12640.8 12844.4 16147.6 16514.4 16547.9 16559.3 16592.9 8928.3 8946.2 9204.9 9297.6 9307.6 8553.3 8562.2 8642.2 8907.5 8912.1 7781.0 7878.0 7990.3 8022.8 8064.6 2206.2 2241.6 2263.4 2265.5 2421.4 985.4 995.7 999.0 1005.2 1022.5 20572.2 20850.6 20964.6 21131.6 21222.8 1000.4 1031.4 1037.7 1057.2 1067.5 10408.3 11224.0 11251.4 11291.7 11292.1 644306.0 656643.0 667105.0 677542.0 679685.0 114525.4 115568.0 116627.4 116640.4 118755.0 1217.2 1232.5 1265.2 1268.3 1268.9 16211.7 16584.5 17124.6 17187.4 17551.8 51525.0 53309.5 53930.0 54003.7 54171.0 63557.0 64248.7 65097.0 66369.7 68580.7 9310.5 9617.8 9633.6 9720.8 10106.4 15291.0 15413.3 15498.7 15508.6 16093.0 12253.6 12932.5 13076.0 13092.7 13230.8 12336.8 12355.5 12393.6 12485.4 12990.8 12720.0 12884.5 13176.3 13288.8 13553.7 9128.5 9355.4 9642.8 9675.8 10019.8 11978.8 12403.0 12872.0 13040.0 13336.3 12:16:03 INFO - PID 3412 | 12:16:03 INFO - PID 3412 | [#3] mootools.html Cycles:180 Average:6748.78 Median:2360.22 stddev:4271.02 (181.0%) stddev-sans-first:4263.38 12:16:03 INFO - PID 3412 | Values: 1301.2 1332.8 1345.9 1356.4 1365.5 10332.3 10655.1 10732.6 10736.7 10755.3 10509.8 10792.9 11000.6 11014.4 11030.9 2292.6 2355.8 2358.9 2361.5 2361.6 1998.5 2227.5 2292.0 2373.1 2376.8 2058.6 2268.0 2343.6 2346.6 2351.7 2256.1 2299.3 2309.0 2310.1 2313.4 2145.5 2150.1 2156.2 2158.7 2159.4 10555.8 10637.6 10644.8 10649.3 10668.7 5943.9 6109.6 6141.8 6144.8 6151.6 3416.2 3471.5 3709.7 3780.1 3790.0 1294.6 1306.7 1322.5 1343.7 1373.5 15405.5 15786.8 15786.8 15791.2 15796.5 5192.8 5420.4 5453.6 5500.9 5565.2 12954.5 12963.1 12981.4 13001.0 13007.3 6328.1 6329.0 6334.6 6336.2 6341.5 5534.4 5547.4 5567.7 5575.1 5579.8 4394.7 4459.0 4494.9 4499.4 4512.2 1176.0 1319.7 1346.1 1348.5 1349.2 707.2 810.8 823.1 837.0 838.9 5731.7 5735.9 5746.5 5797.6 6045.9 937.2 952.7 957.4 968.4 971.7 3648.6 3659.0 3664.7 3665.4 3752.6 13109.2 13621.8 13692.9 13699.8 13725.3 12940.2 13499.1 13542.8 13550.3 13568.4 10049.3 10280.6 10282.4 10291.3 10301.2 6463.5 6671.8 6697.2 6701.8 6715.5 12285.6 12616.5 12627.6 12638.4 12658.1 12586.7 12771.9 12800.9 12833.0 12872.2 8967.4 9165.7 9258.4 9259.6 9263.0 10022.5 10084.0 10088.9 10221.3 10234.9 7286.8 8152.7 8677.7 8770.6 8955.2 8342.2 8563.0 8604.8 8730.3 8808.6 7085.6 7109.9 7160.0 7175.0 7232.8 5549.5 5554.2 5630.1 5659.8 5837.9 5650.5 5660.1 5753.9 5773.2 5818.6 12:16:03 INFO - PID 3412 | 12:16:03 INFO - PID 3412 | [#4] prototype.html Cycles:180 Average:5242.49 Median:5998.52 stddev:1556.57 (25.9%) stddev-sans-first:1518.16 12:16:03 INFO - PID 3412 | Values: 413.8 414.8 430.9 431.4 438.5 5795.3 5994.6 6012.6 6015.3 6024.2 5791.4 5911.8 5926.6 5932.2 5939.2 4405.6 4497.9 4509.8 4510.0 4537.6 4503.3 4508.2 4520.7 4526.9 4538.5 4498.5 4504.0 4510.4 4514.6 4526.9 4428.0 4462.5 4482.8 4491.6 4497.8 3935.0 3936.7 3943.6 3947.8 3960.6 5707.6 5760.3 5768.7 5775.1 5786.2 5183.8 5228.6 5259.3 5316.7 5319.0 6221.7 6247.8 6264.8 6272.9 6280.5 4348.0 4411.2 4459.2 4474.7 4481.6 6220.2 6365.8 6429.7 6498.2 6563.7 4505.7 4549.7 4554.8 4557.9 4579.8 4625.2 4632.5 4636.0 4648.9 4652.1 4965.4 4974.2 5272.4 5293.1 5302.9 6179.3 6228.6 6233.8 6244.9 6281.2 1581.1 1587.0 1598.1 1598.7 1599.2 1057.9 1069.6 1084.9 1089.3 1100.8 5979.4 6004.8 6025.7 6027.8 6056.7 6311.2 6416.8 6419.2 6425.9 6445.4 5969.0 5992.9 6002.4 6027.4 6046.2 3351.1 3378.4 3387.7 3387.9 3399.3 6486.8 6587.5 6611.0 6622.7 6624.8 6512.6 6527.2 6549.7 6568.6 6599.4 6372.9 6701.5 6708.5 6715.4 6716.0 6424.0 6434.9 6439.9 6443.9 6449.5 6179.8 6370.6 6378.6 6397.6 6406.2 6459.3 6557.7 6572.7 6663.2 6732.1 4546.6 4549.8 4569.2 4577.0 4589.8 6335.8 6470.7 6523.4 6531.6 6538.7 6259.7 6273.3 6275.2 6299.4 6309.7 6222.0 6257.9 6258.4 6262.5 6272.3 6058.8 6191.6 6191.7 6211.0 6223.4 6272.7 6311.2 6320.9 6338.2 6339.6 5840.5 6043.2 6071.1 6157.4 6181.7 12:16:03 INFO - PID 3412 | 12:16:03 INFO - PID 3412 | [#5] yui.html Cycles:180 Average:17315.41 Median:4374.41 stddev:22959.74 (524.9%) stddev-sans-first:22990.46 12:16:03 INFO - PID 3412 | Values: 752.3 754.1 755.3 758.7 772.8 15646.8 16185.8 16196.8 16205.8 16209.2 13306.1 13317.3 13318.9 13325.1 13336.9 910.4 920.2 951.1 955.4 961.4 969.4 970.6 973.6 974.0 974.2 1018.4 1021.2 1021.3 1021.4 1021.6 1003.9 1006.7 1006.9 1009.9 1011.7 736.8 741.9 745.1 745.2 745.9 15416.0 15474.5 15689.1 17091.1 17328.8 15275.9 15551.5 15696.7 15859.8 16133.6 12186.1 12252.0 12407.7 12882.5 13378.5 3166.3 3210.5 3241.6 3256.7 3291.0 81406.0 82914.2 83684.6 89791.6 95843.0 12021.2 12210.6 12300.0 12356.2 12478.5 24804.3 25310.4 25726.7 25779.0 26013.2 7760.7 7766.7 7864.9 7896.2 8159.3 3987.8 4046.0 4053.7 4054.4 4068.8 4345.2 4412.3 4421.6 4474.7 4490.1 819.3 819.4 825.1 838.1 854.6 614.5 625.5 631.5 637.7 662.8 9522.9 10084.9 10112.6 10232.5 10332.9 599.7 621.5 622.2 626.6 632.9 4403.6 4472.2 4696.5 4774.8 4812.6 83175.2 84353.6 84375.0 85237.6 85991.0 48313.0 48776.0 52986.2 74497.3 76528.0 61525.0 62193.0 62417.1 63131.7 64665.0 9042.0 9536.4 9921.4 9997.3 10059.7 31142.2 31993.0 32859.7 33233.3 33476.8 53543.5 55172.2 55199.7 55368.0 56328.0 11774.7 11843.1 11881.7 11943.6 12176.1 12588.4 12601.4 12752.2 13015.2 13067.4 11553.9 11653.6 11720.7 11765.7 11936.8 11670.6 11698.5 11772.8 11960.3 12421.8 11123.9 11317.4 11478.4 11850.3 12113.8 8631.3 8880.2 9048.4 9096.3 9148.5 8432.7 9242.6 9356.4 9383.5 9465.4 12:16:03 INFO - PID 3412 | -------- Summary: end -------- 12:16:03 INFO - PID 3412 | 12:16:04 INFO - TEST-INFO | 3412: exit 0 12:16:04 INFO - TEST-OK | dromaeo_css | took 1118178ms 12:16:04 INFO - TEST-START | kraken 12:16:04 INFO - operating with platform_type : linux_ 12:16:04 INFO - Initialising browser for kraken test... 12:16:04 INFO - TEST-INFO | started process 3740 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqrlTLZ/profile http://localhost:36702/getInfo.html) 12:16:08 INFO - PID 3740 | __metrics Screen width/height:1600/1200 12:16:08 INFO - PID 3740 | colorDepth:24 12:16:08 INFO - PID 3740 | Browser inner width/height: 1024/697 12:16:08 INFO - PID 3740 | __metrics 12:16:09 INFO - PID 3740 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:16:09 INFO - PID 3740 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:16:10 INFO - TEST-INFO | 3740: exit 0 12:16:10 INFO - Browser initialized. 12:16:10 INFO - Running cycle 1/1 for kraken test... 12:16:10 INFO - TEST-INFO | started process 3834 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqrlTLZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:16:22 INFO - PID 3834 | RSS: Main: 144375808 12:16:22 INFO - PID 3834 | 12:16:25 INFO - PID 3834 | Cycle 1(1): loaded http://localhost:36702/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36702/tests/kraken/driver.html?testName=audio-beat-detection) 12:16:26 INFO - PID 3834 | RSS: Main: 199499776 12:16:26 INFO - PID 3834 | 12:16:28 INFO - PID 3834 | Cycle 1(1): loaded http://localhost:36702/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36702/tests/kraken/driver.html?testName=audio-dft) 12:16:29 INFO - PID 3834 | RSS: Main: 179605504 12:16:29 INFO - PID 3834 | 12:16:32 INFO - PID 3834 | Cycle 1(1): loaded http://localhost:36702/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36702/tests/kraken/driver.html?testName=audio-fft) 12:16:32 INFO - PID 3834 | RSS: Main: 260894720 12:16:32 INFO - PID 3834 | 12:16:34 INFO - PID 3834 | Cycle 1(1): loaded http://localhost:36702/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36702/tests/kraken/driver.html?testName=audio-oscillator) 12:16:35 INFO - PID 3834 | RSS: Main: 172707840 12:16:35 INFO - PID 3834 | 12:16:37 INFO - PID 3834 | Cycle 1(1): loaded http://localhost:36702/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36702/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:16:38 INFO - PID 3834 | RSS: Main: 177049600 12:16:38 INFO - PID 3834 | 12:16:41 INFO - PID 3834 | Cycle 1(1): loaded http://localhost:36702/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36702/tests/kraken/driver.html?testName=imaging-darkroom) 12:16:41 INFO - PID 3834 | RSS: Main: 215351296 12:16:41 INFO - PID 3834 | 12:16:45 INFO - PID 3834 | Cycle 1(1): loaded http://localhost:36702/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36702/tests/kraken/driver.html?testName=imaging-desaturate) 12:16:45 INFO - PID 3834 | RSS: Main: 228999168 12:16:45 INFO - PID 3834 | 12:16:48 INFO - PID 3834 | Cycle 1(1): loaded http://localhost:36702/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36702/tests/kraken/driver.html?testName=json-parse-financial) 12:16:49 INFO - PID 3834 | RSS: Main: 240762880 12:16:49 INFO - PID 3834 | 12:16:50 INFO - PID 3834 | Cycle 1(1): loaded http://localhost:36702/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36702/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:16:51 INFO - PID 3834 | RSS: Main: 177586176 12:16:51 INFO - PID 3834 | 12:16:53 INFO - PID 3834 | Cycle 1(1): loaded http://localhost:36702/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36702/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:16:53 INFO - PID 3834 | RSS: Main: 184594432 12:16:53 INFO - PID 3834 | 12:16:55 INFO - PID 3834 | Cycle 1(1): loaded http://localhost:36702/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36702/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:16:56 INFO - PID 3834 | RSS: Main: 193826816 12:16:56 INFO - PID 3834 | 12:16:59 INFO - PID 3834 | Cycle 1(1): loaded http://localhost:36702/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36702/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:16:59 INFO - PID 3834 | RSS: Main: 202821632 12:16:59 INFO - PID 3834 | 12:17:02 INFO - PID 3834 | Cycle 1(1): loaded http://localhost:36702/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36702/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:17:03 INFO - PID 3834 | RSS: Main: 199086080 12:17:03 INFO - PID 3834 | 12:17:05 INFO - PID 3834 | Cycle 1(1): loaded http://localhost:36702/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36702/tests/kraken/driver.html?testName=ai-astar) 12:17:05 INFO - PID 3834 | RSS: Main: 268263424 12:17:05 INFO - PID 3834 | 12:17:05 INFO - PID 3834 | __start_tp_report 12:17:05 INFO - PID 3834 | _x_x_mozilla_page_load 12:17:05 INFO - PID 3834 | _x_x_mozilla_page_load_details 12:17:05 INFO - PID 3834 | |i|pagename|runs| 12:17:05 INFO - PID 3834 | |0;ai-astar;102;113;113;111;111;121;116;114;113;112 12:17:05 INFO - PID 3834 | |1;audio-beat-detection;151;118;117;153;122;120;117;117;139;117 12:17:05 INFO - PID 3834 | |2;audio-dft;172;171;171;171;170;173;167;169;164;164 12:17:05 INFO - PID 3834 | |3;audio-fft;74;74;76;119;76;75;77;75;102;75 12:17:05 INFO - PID 3834 | |4;audio-oscillator;82;83;105;83;82;84;101;86;84;107 12:17:05 INFO - PID 3834 | |5;imaging-gaussian-blur;123;123;128;118;114;114;113;114;113;114 12:17:05 INFO - PID 3834 | |6;imaging-darkroom;147;148;148;148;149;148;149;147;148;147 12:17:05 INFO - PID 3834 | |7;imaging-desaturate;94;94;94;94;94;95;94;95;95;95 12:17:05 INFO - PID 3834 | |8;json-parse-financial;54;45;45;46;46;46;47;47;46;46 12:17:05 INFO - PID 3834 | |9;json-stringify-tinderbox;55;56;55;55;55;55;55;54;55;55 12:17:05 INFO - PID 3834 | |10;stanford-crypto-aes;82;85;81;80;83;79;82;80;80;79 12:17:05 INFO - PID 3834 | |11;stanford-crypto-ccm;138;135;130;128;127;127;127;145;175;128 12:17:05 INFO - PID 3834 | |12;stanford-crypto-pbkdf2;185;175;182;182;186;188;188;181;182;183 12:17:05 INFO - PID 3834 | |13;stanford-crypto-sha256-iterative;68;70;67;64;66;71;64;64;63;64 12:17:05 INFO - PID 3834 | __end_tp_report 12:17:05 INFO - PID 3834 | __start_cc_report 12:17:05 INFO - PID 3834 | _x_x_mozilla_cycle_collect,1723 12:17:05 INFO - PID 3834 | __end_cc_report 12:17:05 INFO - PID 3834 | __startTimestamp1491074225310__endTimestamp 12:17:05 INFO - PID 3834 | 12:17:05 INFO - PID 3834 | ------- Summary: start ------- 12:17:05 INFO - PID 3834 | Number of tests: 14 12:17:05 INFO - PID 3834 | 12:17:05 INFO - PID 3834 | [#0] ai-astar Cycles:10 Average:112.60 Median:113.00 stddev:4.74 (4.2%) stddev-sans-first:3.11 12:17:05 INFO - PID 3834 | Values: 102.0 113.0 113.0 111.0 111.0 121.0 116.0 114.0 113.0 112.0 12:17:05 INFO - PID 3834 | 12:17:05 INFO - PID 3834 | [#1] audio-beat-detection Cycles:10 Average:127.10 Median:121.00 stddev:14.72 (12.2%) stddev-sans-first:12.83 12:17:05 INFO - PID 3834 | Values: 151.0 118.0 117.0 153.0 122.0 120.0 117.0 117.0 139.0 117.0 12:17:05 INFO - PID 3834 | 12:17:05 INFO - PID 3834 | [#2] audio-dft Cycles:10 Average:169.20 Median:171.00 stddev:3.19 (1.9%) stddev-sans-first:3.22 12:17:05 INFO - PID 3834 | Values: 172.0 171.0 171.0 171.0 170.0 173.0 167.0 169.0 164.0 164.0 12:17:05 INFO - PID 3834 | 12:17:05 INFO - PID 3834 | [#3] audio-fft Cycles:10 Average:82.30 Median:75.00 stddev:15.42 (20.6%) stddev-sans-first:16.06 12:17:05 INFO - PID 3834 | Values: 74.0 74.0 76.0 119.0 76.0 75.0 77.0 75.0 102.0 75.0 12:17:05 INFO - PID 3834 | 12:17:05 INFO - PID 3834 | [#4] audio-oscillator Cycles:10 Average:89.70 Median:83.00 stddev:10.26 (12.4%) stddev-sans-first:10.50 12:17:05 INFO - PID 3834 | Values: 82.0 83.0 105.0 83.0 82.0 84.0 101.0 86.0 84.0 107.0 12:17:05 INFO - PID 3834 | 12:17:05 INFO - PID 3834 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:116.00 stddev:5.38 (4.6%) stddev-sans-first:5.31 12:17:05 INFO - PID 3834 | Values: 123.0 123.0 128.0 118.0 114.0 114.0 113.0 114.0 113.0 114.0 12:17:05 INFO - PID 3834 | 12:17:05 INFO - PID 3834 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 12:17:05 INFO - PID 3834 | Values: 147.0 148.0 148.0 148.0 149.0 148.0 149.0 147.0 148.0 147.0 12:17:05 INFO - PID 3834 | 12:17:05 INFO - PID 3834 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 12:17:05 INFO - PID 3834 | Values: 94.0 94.0 94.0 94.0 94.0 95.0 94.0 95.0 95.0 95.0 12:17:05 INFO - PID 3834 | 12:17:05 INFO - PID 3834 | [#8] json-parse-financial Cycles:10 Average:46.80 Median:46.00 stddev:2.62 (5.7%) stddev-sans-first:0.71 12:17:05 INFO - PID 3834 | Values: 54.0 45.0 45.0 46.0 46.0 46.0 47.0 47.0 46.0 46.0 12:17:05 INFO - PID 3834 | 12:17:05 INFO - PID 3834 | [#9] json-stringify-tinderbox Cycles:10 Average:55.00 Median:55.00 stddev:0.47 (0.9%) stddev-sans-first:0.50 12:17:05 INFO - PID 3834 | Values: 55.0 56.0 55.0 55.0 55.0 55.0 55.0 54.0 55.0 55.0 12:17:05 INFO - PID 3834 | 12:17:05 INFO - PID 3834 | [#10] stanford-crypto-aes Cycles:10 Average:81.10 Median:81.50 stddev:1.91 (2.3%) stddev-sans-first:2.00 12:17:05 INFO - PID 3834 | Values: 82.0 85.0 81.0 80.0 83.0 79.0 82.0 80.0 80.0 79.0 12:17:05 INFO - PID 3834 | 12:17:05 INFO - PID 3834 | [#11] stanford-crypto-ccm Cycles:10 Average:136.00 Median:132.50 stddev:14.96 (11.3%) stddev-sans-first:15.85 12:17:05 INFO - PID 3834 | Values: 138.0 135.0 130.0 128.0 127.0 127.0 127.0 145.0 175.0 128.0 12:17:05 INFO - PID 3834 | 12:17:05 INFO - PID 3834 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.20 Median:184.00 stddev:3.85 (2.1%) stddev-sans-first:4.03 12:17:05 INFO - PID 3834 | Values: 185.0 175.0 182.0 182.0 186.0 188.0 188.0 181.0 182.0 183.0 12:17:05 INFO - PID 3834 | 12:17:05 INFO - PID 3834 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.50 stddev:2.81 (4.2%) stddev-sans-first:2.89 12:17:05 INFO - PID 3834 | Values: 68.0 70.0 67.0 64.0 66.0 71.0 64.0 64.0 63.0 64.0 12:17:05 INFO - PID 3834 | -------- Summary: end -------- 12:17:05 INFO - PID 3834 | 12:17:06 INFO - TEST-INFO | 3834: exit 0 12:17:06 INFO - TEST-OK | kraken | took 61931ms 12:17:06 INFO - SUITE-END | took 1180s 12:17:06 INFO - Completed test suite (00:19:40) 12:17:06 INFO - javascript benchmark 12:17:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7596.430797347119, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3318.3695097931395, 3343.7325013998866, 3370.966290337096, 3375.5780527434063, 3398.0825177202155, 5670.4896559309655, 5699.116636921273, 5836.299644042716, 5841.912371314434, 5846.736896839642, 5699.515541178995, 5728.140778883169, 5740.5981581289325, 5740.885182296352, 5743.54051675866, 5085.059264036166, 5091.770870310845, 5158.92261616076, 5202.583793296546, 5228.607854410934, 5225.581953443734, 5228.869278268055, 5229.581633469314, 5236.240745091959, 5282.0, 690.4320773932469, 5124.052050370693, 5230.633855630107, 5246.68519888806, 5291.2327712481665, 5107.029664363796, 5125.026245013435, 5152.278680984665, 5209.296744939423, 5214.947850521484, 5133.460986596391, 5140.203268493389, 5145.588352931794, 5145.716985565792, 5188.403333616645, 5678.063119585264, 5745.770169193227, 5771.0, 5775.047117225653, 5825.533957283407, 6150.0, 6151.815445536641, 6240.282367527701, 6284.905726414062, 6317.084022816712, 6333.429991300805, 6378.075179099051, 6392.105105285264, 6394.840128996766, 6394.912864812993, 5921.526277897758, 5929.407059294036, 5930.347661757203, 5931.228940237785, 5934.910976335358, 6272.905906411407, 6287.528435367274, 6417.711202995783, 6485.578437401554, 6505.60966342021, 6220.129181914535, 6225.28409232944, 6232.657203853832, 6233.470155036782, 6235.532335074888, 6105.831093534924, 6281.3404592518045, 6323.494120470444, 6329.588576742497, 6333.68331583419, 6078.179445774852, 6170.167027451326, 6177.042558403455, 6205.565610407228, 6265.65538895356, 6255.374462553799, 6261.060840873814, 6263.812085637438, 6268.874622507525, 6273.592216505913, 4771.785269662873, 4778.832740854054, 4785.186518291899, 4785.306130611042, 4824.734639594856, 4185.518665353462, 4217.072244106292, 4239.682023848224, 4285.121550082225, 4290.099079193405, 5935.821925342247, 5944.346121926585, 5955.076963070731, 5956.434138756811, 5994.310654274727, 6250.499960003189, 6258.186435763321, 6315.747370105236, 6326.082718005863, 6331.4301712845145, 5827.184194212814, 5899.675517846474, 5948.0, 5971.820845374646, 6048.788292409832, 5349.144136938071, 5352.678839269656, 5367.114426119724, 5387.24578559002, 5417.485338892799, 6609.339066093352, 6619.768308109096, 6619.768308109193, 6627.966860165861, 6630.403263706289, 6095.529019716752, 6121.452973575903, 6241.282252541016, 6348.301686814539, 6349.301576826453, 6469.126667899962, 6513.185851768529, 6545.803625891231, 6550.8362290943105, 6560.9343906562235, 6204.565680402509, 6209.161763161916, 6211.3478084802255, 6212.161358216583, 6247.781327653692, 6094.75620975156, 6119.868162944114, 6268.592541484789, 6305.495560355253, 6326.335734747785, 6103.389661034039, 6119.959572021022, 6122.550631083031, 6125.052321062068, 6131.651934473353, 6098.825584107018, 6108.8778224436155, 6115.483736156635, 6116.0010150213275, 6116.944513560587, 5954.493868021266, 5955.5235581154275, 6001.2498437695285, 6048.092786082123, 6092.390760923872, 6131.693415329305, 6157.599756015845, 6181.721822517908, 6187.752489900354, 6201.1628430163155, 5989.610675306091, 6000.399960004139, 6001.729922153426, 6002.459778619946, 6017.458428741435], "value": 5714.63943760781, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [751.8233215194429, 806.4234072638062, 820.1306614988112, 1141.6403832792664, 1160.2980196980832, 31909.0, 40031.79984100079, 40199.79900100503, 40378.0, 40499.0, 43714.78142609291, 44026.0, 44053.0, 44099.0, 44119.33820992688, 6270.0, 6428.453581445559, 8214.096449390563, 8362.080171181165, 8363.665453381887, 8146.551939643317, 8366.0, 8374.371922105867, 8375.95812020939, 8383.035950865637, 8423.157684231559, 8501.489910605353, 8506.36202284828, 8507.659693612279, 8548.78628034301, 8386.287165590933, 8470.534120623362, 8471.279941204974, 8493.74518764432, 8494.660213591449, 8296.70961516344, 8335.0, 8345.707900223524, 8365.0, 8366.53984030878, 41755.0, 41865.581344186474, 41889.79055104736, 41975.580244197474, 42107.57892421067, 2900.9274768130754, 2910.3015276333526, 2912.89804856829, 2934.105097945126, 2947.5283954567167, 27862.442751145067, 27987.720122798713, 28089.43821123566, 28154.859225703945, 28221.15336539907, 3576.6065732769375, 3582.6417358264225, 3607.188382613891, 3644.0, 3672.375696131664, 192956.0, 193335.0, 193401.0, 193480.9999999986, 194358.0, 48804.947183715, 49306.0, 49385.259221111715, 49454.258186127234, 49472.50527494679, 50458.747706261966, 50910.74544627253, 51140.0, 51142.0, 51213.74393128085, 15438.382464701286, 15523.223838808015, 15525.922370388076, 15548.0, 15548.533543993699, 10544.261901666963, 10721.946390268155, 12274.140810143383, 12404.62786116418, 12442.440090195963, 14737.336819843133, 14748.115113093249, 14903.254837258311, 14913.403463861541, 15044.924775376054, 5817.7963771267805, 5821.825345239565, 5886.381929897385, 5903.0224874667465, 5983.252093488314, 1060.3955745225148, 1062.9362238265728, 1065.8507808906604, 1073.1629329123296, 1097.1332647208617, 26235.0, 26405.47189056208, 26703.46593068128, 26924.730752692223, 26966.865165674048, 1149.4252873563219, 1168.9649310520697, 1170.8068168752231, 1172.9178957472895, 1217.7503611759569, 13983.161010339412, 14034.578962631138, 14175.85824141766, 14238.644033899029, 14284.0, 307178.0, 310340.0, 310382.0, 310408.0, 364187.0, 61507.38492615017, 61543.38456615466, 62061.37938620556, 62307.0, 62353.37646623566, 1445.9855401446061, 1476.645605054779, 1479.186447453896, 1487.9256037198097, 1497.827749808786, 29456.852715737143, 31329.68670313359, 31372.686273136977, 31700.207494811893, 31775.36449271048, 42012.789936050125, 52570.73714631402, 53522.73238633782, 53532.73233633807, 53570.0, 337553.0, 341115.0, 341429.0, 345156.0, 345907.0, 28061.71938280591, 28566.0, 28590.571141433313, 36553.45169822402, 36857.26285474329, 36688.816555918114, 42623.57376426196, 43490.782546087066, 43735.34396984112, 44741.32888006748, 32843.34313313768, 32889.34221315608, 33160.336793263516, 33213.33573328568, 33309.83345083259, 32201.51697724489, 32788.34423311472, 33026.66973330236, 33160.834195828866, 33876.83061584676, 38186.42720359141, 39187.216255675296, 39209.803950980066, 39257.41113883237, 39288.6071139285, 32873.34253314872, 33107.337853242316, 33256.0, 33368.0, 33791.662083378855, 26565.22238364102, 27458.17625471239, 27463.588046179724, 27557.244275572284, 27865.58201627018], "value": 18191.929093070976, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.55519764276966, 449.2183600535068, 449.64702708373915, 462.76167773596603, 462.94444666640004, 19933.900330498345, 20759.0, 21464.463388415257, 21508.677369839425, 21658.566828663435, 22969.770302296973, 23190.536189276205, 23360.415989600267, 23569.29292121235, 23642.0, 6124.663143527104, 6162.383761623835, 6165.907511387333, 6224.968875155618, 6284.214473190851, 6150.938490615104, 6216.751329946819, 6226.844328891769, 6236.906446403307, 6252.09311160096, 6056.636601803906, 6150.815475535741, 6155.630662160284, 6162.383761623824, 6185.969070154665, 5919.1713160157615, 6149.723262453201, 6173.32093469718, 6189.350118237565, 6196.81409557714, 5494.862628434281, 5533.557315414757, 5538.0, 5539.446055394428, 5541.196526503634, 26285.21144365672, 26336.34159146037, 26768.0, 27139.592906106423, 27326.0, 2012.748406449194, 2042.867213631124, 2044.2640649366217, 2050.29264903608, 2070.3995841206033, 16344.591385215346, 16429.58926026847, 16851.157442127846, 16886.493405197863, 17302.480925572254, 2104.736907886514, 2108.3674897530677, 2113.6406810842195, 2154.1706443019552, 2168.0894024509744, 107103.0, 110832.9999999992, 111190.44404778005, 111386.44306778496, 111730.44134779274, 11476.770464590662, 12285.262884226975, 12589.370531473389, 12640.810387844189, 12844.357782110857, 16147.596310092107, 16514.42199523011, 16547.917260413862, 16559.25483353228, 16592.917035414746, 8928.330375221754, 8946.194842464209, 9204.907950920538, 9297.581608827619, 9307.581158847868, 8553.315734741205, 8562.229399354088, 8642.22220000203, 8907.465552066897, 8912.108789121035, 7780.961095194488, 7878.0, 7990.280874721187, 8022.79943001418, 8064.637091330904, 2206.1837120265604, 2241.5853067182625, 2263.445455863291, 2265.4902646904316, 2421.418859473749, 985.4186030242191, 995.746084748399, 998.9550470228858, 1005.2209537608265, 1022.4529876516028, 20572.177112915317, 20850.58298834045, 20964.580708386053, 21131.577368452545, 21222.75544891028, 1000.3997601439224, 1031.437866362834, 1037.6886933919793, 1057.2282233969245, 1067.4662668665667, 10408.323458975143, 11224.0, 11251.381174035507, 11291.717707057389, 11292.096632269398, 644306.0, 656643.0, 667105.0, 677542.0, 679685.0, 114525.4273728626, 115568.0, 116627.41686291514, 116640.41679791547, 118755.0, 1217.190568272107, 1232.5439587352557, 1265.1586694848006, 1268.2770820632336, 1268.898488120948, 16211.675766484841, 16584.50246492607, 17124.571885702957, 17187.398441055004, 17551.82448175502, 51525.0, 53309.46690533045, 53929.99999999843, 54003.72998134984, 54171.0, 63557.0, 64248.67875660592, 65097.0, 66369.66815165893, 68580.6570967142, 9310.534473276173, 9617.807643847224, 9633.566489507848, 9720.805583888141, 10106.39361638304, 15291.0, 15413.306401211748, 15498.690026199187, 15508.612284692974, 16093.0, 12253.632391028283, 12932.547360842325, 13076.0, 13092.738145236852, 13230.82460209562, 12336.81494777561, 12355.505779768708, 12393.62819115428, 12485.375731213584, 12990.805137922749, 12720.04599655011, 12884.549040783902, 13176.341182941007, 13288.800667990181, 13553.728925421634, 9128.543572821465, 9355.391899526508, 9642.807143857224, 9675.806483870423, 10019.799604007732, 11978.820317695066, 12403.0, 12872.034597405045, 13040.0, 13336.266505342299], "value": 10508.858539454946, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1301.1867582760774, 1332.793417020362, 1345.9192448453086, 1356.4302992743046, 1365.5015919189498, 10332.276740628158, 10655.147588192945, 10732.570697172103, 10736.677899663004, 10755.300905441141, 10509.84235236472, 10792.946035269832, 11000.614978475754, 11014.39420831854, 11030.889691103086, 2292.564412761574, 2355.8233132515043, 2358.905643774247, 2361.527694461106, 2361.551305252005, 1998.450426132818, 2227.487677834099, 2292.037344315383, 2373.050779688121, 2376.786089251967, 2058.557410156816, 2267.9886600566974, 2343.60158773009, 2346.6480027995767, 2351.670766092748, 2256.108837009372, 2299.2642354446584, 2308.976910230893, 2310.06442390832, 2313.4332088638225, 2145.452909508081, 2150.1184514349043, 2156.1590979518, 2158.665406861939, 2159.4169574214875, 10555.788884222273, 10637.57449702011, 10644.840327395095, 10649.307794993378, 10668.679939601825, 5943.910841337383, 6109.5723299369065, 6141.785037523665, 6144.815655530341, 6151.6001459904965, 3416.180116771982, 3471.513988041651, 3709.7403181777286, 3780.111673756665, 3790.014596204979, 1294.5792617399288, 1306.6798634334555, 1322.5187789675529, 1343.6909510812568, 1373.4849431463201, 15405.460808871749, 15786.842131578653, 15786.842131578653, 15791.210439478094, 15796.526104216891, 5192.792288308501, 5420.430854760193, 5453.563714902798, 5500.944990550043, 5565.16522521625, 12954.481820727255, 12963.092583519252, 12981.41583628739, 13001.024923130803, 13007.284599346938, 6328.145700330489, 6329.0, 6334.588251763621, 6336.17629708135, 6341.4609758170145, 5534.418886016991, 5547.362053363834, 5567.66594004361, 5575.080111781592, 5579.776808927679, 4394.714343567658, 4458.977705111453, 4494.887627809331, 4499.370088187657, 4512.210363186429, 1175.9647210583696, 1319.663485811112, 1346.1451977994045, 1348.548236340817, 1349.1702602899343, 707.2008630247788, 810.8337790752881, 823.0945959444563, 836.9790755231046, 838.8951381077366, 5731.742071606787, 5735.913961290584, 5746.511546518593, 5797.623154494944, 6045.939540604538, 937.2174234514257, 952.7237101240701, 957.4255446731905, 968.4431451915177, 971.7182017214928, 3648.6351364863303, 3658.9634103659155, 3664.72514561409, 3665.4318580620047, 3752.605976372496, 13109.213447193199, 13621.84214341792, 13692.863071369358, 13699.794503082461, 13725.313734313444, 12940.223586584834, 13499.055066145276, 13542.796858047137, 13550.322483875767, 13568.389422476012, 10049.346792458467, 10280.588776448858, 10282.434466104436, 10291.33106348085, 10301.227407944285, 6463.482921366373, 6671.766488172891, 6697.162854643169, 6701.8324541884895, 6715.462762978852, 12285.631431057083, 12616.49534018629, 12627.558035468715, 12638.43127059303, 12658.11393202467, 12586.748265034832, 12771.872281277068, 12800.935995319964, 12833.0, 12872.22766634005, 8967.372283940062, 9165.679201227926, 9258.444493330422, 9259.629614815602, 9263.0, 10022.548985295532, 10084.0, 10088.949555252177, 10221.33561318512, 10234.948825255826, 7286.781396558112, 8152.673893044212, 8677.652893884426, 8770.561471926505, 8955.238804701674, 8342.249197572248, 8563.0, 8604.827903442021, 8730.301575874042, 8808.5595720215, 7085.645717713991, 7109.928900711134, 7160.0, 7174.964125179341, 7232.783016509513, 5549.500544950974, 5554.1946417770005, 5630.071038278638, 5659.830205093854, 5837.883242335045, 5650.491455769001, 5660.122680984454, 5753.942460575341, 5773.220615216892, 5818.6217895836635], "value": 5117.2792210902035, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [413.7806962309976, 414.7615121305249, 430.8996768252425, 431.39389158232694, 438.46069334718294, 5795.3335366432875, 5994.610350327226, 6012.639241645499, 6015.278166620006, 6024.186734790813, 5791.420857914207, 5911.763529458827, 5926.585139040269, 5932.1991531143285, 5939.198208241886, 4405.6475481961525, 4497.865064048084, 4509.751963641998, 4509.954900450986, 4537.551460889731, 4503.301988191819, 4508.211063063967, 4520.660950428714, 4526.864194074183, 4538.523455037223, 4498.50516443191, 4503.977480112595, 4510.436195475566, 4514.638828893697, 4526.8868278292975, 4428.0, 4462.4645042594775, 4482.843100491467, 4491.6182124519455, 4497.775111244441, 3934.960650393488, 3936.7441116327345, 3943.6056394360335, 3947.782871942042, 3960.5643379228263, 5707.6290041147195, 5760.279965004374, 5768.673205162794, 5775.1337299405, 5786.1610066540115, 5183.792648294064, 5228.588281164064, 5259.316288882421, 5316.707581083039, 5319.0, 6221.657808820513, 6247.812565623039, 6264.843378915563, 6272.874542509125, 6280.466160376373, 4348.0, 4411.228035093878, 4459.175052615245, 4474.709143905636, 4481.574250446235, 6220.205674538528, 6365.777197798101, 6429.742810287583, 6498.155239818793, 6563.671816409208, 4505.7296562206375, 4549.727016379028, 4554.817807287672, 4557.863264102082, 4579.793909274091, 4625.236835922103, 4632.513586073481, 4635.976820115878, 4648.907021859612, 4652.092841895797, 4965.404151501771, 4974.1543937530705, 5272.367315922037, 5293.12663410533, 5302.92045619316, 6179.3202747697715, 6228.595141315891, 6233.844153896098, 6244.875922333933, 6281.152044473937, 1581.1145758375346, 1586.9764002218506, 1598.057146283698, 1598.7362085256036, 1599.2483532739593, 1057.8571892794528, 1069.647016484574, 1084.9403282819362, 1089.2647462962627, 1100.757833276678, 5979.372165922602, 6004.849878753066, 6025.698715064229, 6027.819165425044, 6056.727447264883, 6311.179546658905, 6416.807495775134, 6419.165508483868, 6425.935740642627, 6445.388652836791, 5968.970155149196, 5992.850178745479, 6002.429769171922, 6027.397260274025, 6046.183765191643, 3351.111955331839, 3378.408778463808, 3387.7289816814596, 3387.9497355819776, 3399.320135972766, 6486.772962946368, 6587.53887227899, 6611.0, 6622.735090596419, 6624.8343791405605, 6512.641804700692, 6527.2167339919515, 6549.705263263165, 6568.638724870178, 6599.439047681001, 6372.852886480386, 6701.463882889455, 6708.463322934153, 6715.4291885190305, 6715.999999999903, 6424.0, 6434.935650643433, 6439.871202576016, 6443.903341449975, 6449.451796597342, 6179.76404719067, 6370.649614271259, 6378.596708724073, 6397.648129352744, 6406.231252249573, 6459.289478157493, 6557.704903279268, 6572.704228309642, 6663.233728121328, 6732.124823772878, 4546.61353784932, 4549.79525921341, 4569.1547063793305, 4576.954230457653, 4589.816407343669, 6335.809925702236, 6470.741170353133, 6523.412892839668, 6531.608103513804, 6538.738450462119, 6259.6870156492905, 6273.341299163522, 6275.152854364603, 6299.433051025429, 6309.747610095545, 6221.96889015552, 6257.937420625735, 6258.3741625838875, 6262.4990000800735, 6272.310045894857, 6058.787942421994, 6191.628502289877, 6191.659458729813, 6211.0372892201785, 6223.408776166257, 6272.749090036347, 6311.2426508819235, 6320.936790632035, 6338.176037115146, 6339.639990804881, 5840.503557197686, 6043.214382130295, 6071.089336599545, 6157.4298553868475, 6181.660008699385], "value": 4763.676710496588, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [752.2890868129618, 754.0611938137021, 755.2636179724769, 758.6965213914433, 772.8029352515111, 15646.84353156468, 16185.83814161858, 16196.75704864428, 16205.83794162058, 16209.189540522972, 13306.06857519974, 13317.334133293345, 13318.866811331884, 13325.067245292834, 13336.866631333683, 910.3627460777449, 920.22241206181, 951.0727041134872, 955.4267439536258, 961.4279503695325, 969.3505351414569, 970.611755297883, 973.6446197138065, 973.9561719722594, 974.2157563161652, 1018.3940555369543, 1021.1881554164457, 1021.325924889573, 1021.366752613377, 1021.6322124035379, 1003.9447830369327, 1006.7281833904841, 1006.9446180460071, 1009.8838633557161, 1011.7015480433253, 736.7826491185114, 741.929516695913, 745.0723848808215, 745.1803016681661, 745.8508298340354, 15416.0, 15474.45839395627, 15689.137097459636, 17091.14544272794, 17328.826711732847, 15275.923620381827, 15551.533453996399, 15696.686066278611, 15859.762103568455, 16133.596660083474, 12186.146969712123, 12252.0, 12407.689807754788, 12882.549110781172, 13378.531751388751, 3166.335069635379, 3210.5184222366597, 3241.6110066792135, 3256.690614391629, 3291.0, 81406.0, 82914.17085829064, 83684.58157709173, 89791.55104224502, 95843.0, 12021.218620789796, 12210.633680989584, 12300.0, 12356.196847204903, 12478.500859965681, 24804.255872323858, 25310.367240819127, 25726.74273257281, 25779.0, 26013.219603411548, 7760.650770715331, 7766.728164514328, 7864.921350786533, 7896.210378962172, 8159.26566609008, 3987.8205480753436, 4045.959540404558, 4053.7365071270274, 4054.412110244057, 4068.7762173080764, 4345.196138714348, 4412.271975124133, 4421.557844215553, 4474.664400169935, 4490.124425737015, 819.3445243804932, 819.4059307002376, 825.145973917005, 838.1199740272689, 854.6239654551978, 614.4961131871911, 625.5433533520555, 631.5200447659812, 637.6556659403963, 662.840918179643, 9522.90477095234, 10084.899151008543, 10112.59549618007, 10232.525668579887, 10332.896671033344, 599.7271241585069, 621.4903778901257, 622.2408661433044, 626.5958456795341, 632.8797528469576, 4403.625691816232, 4472.172648060119, 4696.507712280474, 4774.809007639656, 4812.590929771009, 83175.16824831674, 84353.57823210968, 84375.01558657938, 85237.57381213055, 85991.0, 48313.0, 48776.0, 52986.20520692193, 74497.25502745011, 76528.0, 61525.0, 62193.0, 62417.06374404387, 63131.684341577995, 64665.0, 9042.0, 9536.380135291183, 9921.40471571708, 9997.250206234707, 10059.724617037584, 31142.22144446407, 31993.0, 32859.67140328566, 33233.33533329368, 33476.83261583676, 53543.46456535385, 55172.17241741457, 55199.72400138134, 55368.0, 56328.0, 11774.705632359259, 11843.11176661771, 11881.702957425789, 11943.641690749291, 12176.055951590943, 12588.370581471074, 12601.382993563358, 12752.234865908074, 13015.219086854819, 13067.411966461343, 11553.884461155281, 11653.59212427561, 11720.70698232551, 11765.705857353634, 11936.820947685965, 11670.591529296435, 11698.532058717556, 11772.82340764872, 11960.282383057045, 12421.75156496883, 11123.888761112608, 11317.377544234816, 11478.368689722145, 11850.348230847387, 12113.757724845278, 8631.26634236097, 8880.1563851434, 9048.366614336934, 9096.27229821626, 9148.542572871196, 8432.747017589481, 9242.584083716114, 9356.438613682929, 9383.530823458936, 9465.384749991228], "value": 7214.705219169791, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1508.7999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 113.0, 113.0, 111.0, 111.0, 121.0, 116.0, 114.0, 113.0, 112.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 118.0, 117.0, 153.0, 122.0, 120.0, 117.0, 117.0, 139.0, 117.0], "value": 127.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 171.0, 171.0, 171.0, 170.0, 173.0, 167.0, 169.0, 164.0, 164.0], "value": 169.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 76.0, 119.0, 76.0, 75.0, 77.0, 75.0, 102.0, 75.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 105.0, 83.0, 82.0, 84.0, 101.0, 86.0, 84.0, 107.0], "value": 89.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 123.0, 128.0, 118.0, 114.0, 114.0, 113.0, 114.0, 113.0, 114.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 148.0, 148.0, 149.0, 148.0, 149.0, 147.0, 148.0, 147.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 45.0, 45.0, 46.0, 46.0, 46.0, 47.0, 47.0, 46.0, 46.0], "value": 46.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 55.0, 55.0, 55.0, 55.0, 55.0, 54.0, 55.0, 55.0], "value": 55.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 85.0, 81.0, 80.0, 83.0, 79.0, 82.0, 80.0, 80.0, 79.0], "value": 81.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 135.0, 130.0, 128.0, 127.0, 127.0, 127.0, 145.0, 175.0, 128.0], "value": 136.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 175.0, 182.0, 182.0, 186.0, 188.0, 188.0, 181.0, 182.0, 183.0], "value": 183.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 67.0, 64.0, 66.0, 71.0, 64.0, 64.0, 63.0, 64.0], "value": 66.1, "unit": "score"}]}]} 12:17:06 INFO - Return code: 0 12:17:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:17:06 ERROR - # TBPL SUCCESS # 12:17:06 INFO - Running post-action listener: _resource_record_post_action 12:17:06 INFO - [mozharness: 2017-04-01 19:17:06.639581Z] Finished run-tests step (success) 12:17:06 INFO - Running post-run listener: _resource_record_post_run 12:17:06 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 7512064; Write bytes: 369430528; Read time: 1568; Write time: 291188 12:17:06 INFO - TinderboxPrint: CPU usage
13.0% 12:17:06 INFO - TinderboxPrint: I/O read bytes / time
7,512,064 / 1,568 12:17:06 INFO - TinderboxPrint: I/O write bytes / time
369,430,528 / 291,188 12:17:06 INFO - TinderboxPrint: CPU idle
8,313.5 (87.0%) 12:17:06 INFO - TinderboxPrint: CPU user
1,189.3 (12.4%) 12:17:06 INFO - TinderboxPrint: Swap in / out
0 / 0 12:17:06 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 112160768; Read time: 44; Write time: 100548 12:17:06 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 5292032; Write bytes: 257269760; Read time: 1360; Write time: 190640 12:17:07 INFO - Running post-run listener: _upload_blobber_files 12:17:07 INFO - Blob upload gear active. 12:17:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:17:07 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 12:17:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:17:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:17:07 INFO - (blobuploader) - INFO - Open directory for files ... 12:17:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:17:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:17:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:17:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:17:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:17:10 INFO - (blobuploader) - INFO - Done attempting. 12:17:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:17:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:17:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:17:11 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:17:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:17:11 INFO - (blobuploader) - INFO - Done attempting. 12:17:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:17:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:17:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:17:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:17:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:17:13 INFO - (blobuploader) - INFO - Done attempting. 12:17:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:17:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:17:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:17:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:17:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:17:17 INFO - (blobuploader) - INFO - Done attempting. 12:17:17 INFO - (blobuploader) - INFO - Iteration through files over. 12:17:18 INFO - Return code: 0 12:17:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:17:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:17:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2950b654b49c2255c0917248159ad14abbd22e89244242d5fa66e2e0eb09ebd7856ebce9fd18837c4a07d862069ad059f1b51f0a6a61f829d3699ab8d545ba0d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c25aca7e04b2505263040f71cc04d85cd28eb37a0ff5b64439183b877e4f2acb08f1510004c0d508cc7eb66ed0bf9183a5410d3c0ac1f119cad139991caa87f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f2a49c66f7faa5a359277eba5b4a19621a5b07a0d3a0a09670309057214b636191da82cd4c6e50390486e3744aee7c71fef97374e55ea1d4c380fd72b720cb5b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b2e9f28f6e8b2c5ffd98419b13e7b3e56e7528e3a801a65d3ecd14747e9195f67a4bb7d1308395eda90282022c45fe3e44c61ea6ef8e269c7263d9178fe237b2"} 12:17:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:17:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:17:18 INFO - Contents: 12:17:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2950b654b49c2255c0917248159ad14abbd22e89244242d5fa66e2e0eb09ebd7856ebce9fd18837c4a07d862069ad059f1b51f0a6a61f829d3699ab8d545ba0d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c25aca7e04b2505263040f71cc04d85cd28eb37a0ff5b64439183b877e4f2acb08f1510004c0d508cc7eb66ed0bf9183a5410d3c0ac1f119cad139991caa87f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f2a49c66f7faa5a359277eba5b4a19621a5b07a0d3a0a09670309057214b636191da82cd4c6e50390486e3744aee7c71fef97374e55ea1d4c380fd72b720cb5b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b2e9f28f6e8b2c5ffd98419b13e7b3e56e7528e3a801a65d3ecd14747e9195f67a4bb7d1308395eda90282022c45fe3e44c61ea6ef8e269c7263d9178fe237b2"} 12:17:18 INFO - Running post-run listener: copy_logs_to_upload_dir 12:17:18 INFO - Copying logs to upload dir... 12:17:18 INFO - mkdir: /builds/slave/test/build/upload/logs 12:17:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.392627 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2017-04-01 12:17:18.092111) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-01 12:17:18.098244) ========= 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-1491071570.662924-91094382 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2950b654b49c2255c0917248159ad14abbd22e89244242d5fa66e2e0eb09ebd7856ebce9fd18837c4a07d862069ad059f1b51f0a6a61f829d3699ab8d545ba0d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c25aca7e04b2505263040f71cc04d85cd28eb37a0ff5b64439183b877e4f2acb08f1510004c0d508cc7eb66ed0bf9183a5410d3c0ac1f119cad139991caa87f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f2a49c66f7faa5a359277eba5b4a19621a5b07a0d3a0a09670309057214b636191da82cd4c6e50390486e3744aee7c71fef97374e55ea1d4c380fd72b720cb5b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b2e9f28f6e8b2c5ffd98419b13e7b3e56e7528e3a801a65d3ecd14747e9195f67a4bb7d1308395eda90282022c45fe3e44c61ea6ef8e269c7263d9178fe237b2"} build_url:https://queue.taskcluster.net/v1/task/Nzt4cWyVR9CwgazV4zVRow/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011243 build_url: 'https://queue.taskcluster.net/v1/task/Nzt4cWyVR9CwgazV4zVRow/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2950b654b49c2255c0917248159ad14abbd22e89244242d5fa66e2e0eb09ebd7856ebce9fd18837c4a07d862069ad059f1b51f0a6a61f829d3699ab8d545ba0d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c25aca7e04b2505263040f71cc04d85cd28eb37a0ff5b64439183b877e4f2acb08f1510004c0d508cc7eb66ed0bf9183a5410d3c0ac1f119cad139991caa87f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f2a49c66f7faa5a359277eba5b4a19621a5b07a0d3a0a09670309057214b636191da82cd4c6e50390486e3744aee7c71fef97374e55ea1d4c380fd72b720cb5b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b2e9f28f6e8b2c5ffd98419b13e7b3e56e7528e3a801a65d3ecd14747e9195f67a4bb7d1308395eda90282022c45fe3e44c61ea6ef8e269c7263d9178fe237b2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-01 12:17:18.124950) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-01 12:17:18.125326) ========= 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-1491071570.662924-91094382 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004474 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-01 12:17:18.210067) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-01 12:17:18.210442) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-01 12:17:18.210814) ========= ========= Total master_lag: 0.20 =========