builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-015 starttime: 1486385980.67 results: success (0) revision: c5621cb6f9075d731ccb28dcf20dd29deae2bddd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-06 04:59:40.666909) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-06 04:59:40.667370) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-06 04:59:40.667666) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-06 04:59:40.684109) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 04:59:40.684452) ========= 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=20e666a3d4cfbb71505a330e000001b4-1486385980.116267-93126986 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-06 04:59:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.6M=0s 2017-02-06 04:59:40 (45.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.070166 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 04:59:40.768011) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 04:59:40.768324) ========= 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=20e666a3d4cfbb71505a330e000001b4-1486385980.116267-93126986 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014258 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 04:59:40.817808) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 04:59:40.818155) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c5621cb6f9075d731ccb28dcf20dd29deae2bddd --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 c5621cb6f9075d731ccb28dcf20dd29deae2bddd --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=20e666a3d4cfbb71505a330e000001b4-1486385980.116267-93126986 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-06 04:59:40,882 truncating revision to first 12 chars 2017-02-06 04:59:40,882 Setting DEBUG logging. 2017-02-06 04:59:40,882 attempt 1/10 2017-02-06 04:59:40,882 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c5621cb6f907?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-06 04:59:41,207 unpacking tar archive at: mozilla-central-c5621cb6f907/testing/mozharness/ program finished with exit code 0 elapsedTime=0.625607 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 04:59:41.456478) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-06 04:59:41.456804) ========= script_repo_revision: c5621cb6f9075d731ccb28dcf20dd29deae2bddd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-06 04:59:41.457203) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-06 04:59:41.457467) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-06 04:59:41.466708) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2017-02-06 04:59:41.467110) ========= /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=20e666a3d4cfbb71505a330e000001b4-1486385980.116267-93126986 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:59:41 INFO - MultiFileLogger online at 20170206 04:59:41 in /builds/slave/test 04:59:41 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 04:59:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:59:41 INFO - {'append_to_log': False, 04:59:41 INFO - 'base_work_dir': '/builds/slave/test', 04:59:41 INFO - 'blob_upload_branch': 'Firefox', 04:59:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:59:41 INFO - 'branch': 'Firefox', 04:59:41 INFO - 'buildbot_json_path': 'buildprops.json', 04:59:41 INFO - 'config_files': ('talos/linux_config.py',), 04:59:41 INFO - 'default_actions': ('clobber', 04:59:41 INFO - 'read-buildbot-config', 04:59:41 INFO - 'download-and-extract', 04:59:41 INFO - 'populate-webroot', 04:59:41 INFO - 'create-virtualenv', 04:59:41 INFO - 'install', 04:59:41 INFO - 'run-tests'), 04:59:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:59:41 INFO - 'download_minidump_stackwalk': True, 04:59:41 INFO - 'download_symbols': 'ondemand', 04:59:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:59:41 INFO - 'tooltool.py': '/tools/tooltool.py', 04:59:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:59:41 INFO - '/tools/misc-python/virtualenv.py')}, 04:59:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:59:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:59:41 INFO - 'installer_path': 'installer.exe', 04:59:41 INFO - 'log_level': 'info', 04:59:41 INFO - 'log_name': 'talos', 04:59:41 INFO - 'log_to_console': True, 04:59:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:59:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:59:41 INFO - 'opt_config_files': (), 04:59:41 INFO - 'pip_index': False, 04:59:41 INFO - 'sps_profile': False, 04:59:41 INFO - 'sps_profile_interval': 0, 04:59:41 INFO - 'suite': 'dromaeojs', 04:59:41 INFO - 'system_bits': '32', 04:59:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:59:41 INFO - 'title': 'talos-linux64-ix-015', 04:59:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:59:41 INFO - 'use_talos_json': True, 04:59:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:59:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:59:41 INFO - 'work_dir': 'build'} 04:59:41 INFO - [mozharness: 2017-02-06 12:59:41.631339Z] Running clobber step. 04:59:41 INFO - Running pre-action listener: _resource_record_pre_action 04:59:41 INFO - Running main action method: clobber 04:59:41 INFO - rmtree: /builds/slave/test/build 04:59:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:59:42 INFO - Running post-action listener: _resource_record_post_action 04:59:42 INFO - [mozharness: 2017-02-06 12:59:42.606075Z] Finished clobber step (success) 04:59:42 INFO - [mozharness: 2017-02-06 12:59:42.606176Z] Running read-buildbot-config step. 04:59:42 INFO - Running pre-action listener: _resource_record_pre_action 04:59:42 INFO - Running main action method: read_buildbot_config 04:59:42 INFO - Using buildbot properties: 04:59:42 INFO - { 04:59:42 INFO - "project": "", 04:59:42 INFO - "product": "firefox", 04:59:42 INFO - "who": "cbook@mozilla.com", 04:59:42 INFO - "installer_path": "public/build/target.tar.bz2", 04:59:42 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:59:42 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 04:59:42 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 04:59:42 INFO - "stage_platform": "linux64-pgo", 04:59:42 INFO - "basedir": "/builds/slave/test", 04:59:42 INFO - "buildnumber": 15, 04:59:42 INFO - "platform": "ubuntu64_hw", 04:59:42 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:59:42 INFO - "slavebuilddir": "test", 04:59:42 INFO - "taskId": "D1NLYvKISIaopPH9botwTg", 04:59:42 INFO - "branch": "mozilla-central", 04:59:42 INFO - "script_repo_revision": "production", 04:59:42 INFO - "revision": "c5621cb6f9075d731ccb28dcf20dd29deae2bddd", 04:59:42 INFO - "slavename": "talos-linux64-ix-015", 04:59:42 INFO - "repo_path": "mozilla-central" 04:59:42 INFO - } 04:59:42 INFO - Finding installer, test and symbols from parent task. 04:59:42 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D1NLYvKISIaopPH9botwTg'}, attempt #1 04:59:43 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D1NLYvKISIaopPH9botwTg'}, attempt #1 04:59:43 INFO - Task dependencies: VO4h69AGST2XKTj92I1ebQ 04:59:43 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VO4h69AGST2XKTj92I1ebQ'}, attempt #1 04:59:44 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/VO4h69AGST2XKTj92I1ebQ/artifacts/public/build/target.tar.bz2 04:59:44 INFO - Set test_url: https://queue.taskcluster.net/v1/task/VO4h69AGST2XKTj92I1ebQ/artifacts/public/build/test_packages.json 04:59:44 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/VO4h69AGST2XKTj92I1ebQ/artifacts/public/build/target.crashreporter-symbols.zip 04:59:44 INFO - Running post-action listener: _resource_record_post_action 04:59:44 INFO - [mozharness: 2017-02-06 12:59:44.003012Z] Finished read-buildbot-config step (success) 04:59:44 INFO - [mozharness: 2017-02-06 12:59:44.003235Z] Running download-and-extract step. 04:59:44 INFO - Running pre-action listener: _resource_record_pre_action 04:59:44 INFO - Running main action method: download_and_extract 04:59:44 INFO - mkdir: /builds/slave/test/build/tests 04:59:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:59:44 INFO - trying https://queue.taskcluster.net/v1/task/VO4h69AGST2XKTj92I1ebQ/artifacts/public/build/target.test_packages.json 04:59:44 INFO - Downloading https://queue.taskcluster.net/v1/task/VO4h69AGST2XKTj92I1ebQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 04:59:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VO4h69AGST2XKTj92I1ebQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 04:59:44 INFO - Downloaded 896 bytes. 04:59:44 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 04:59:44 INFO - Using the following test package requirements: 04:59:44 INFO - {u'common': [u'target.common.tests.zip'], 04:59:44 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 04:59:44 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 04:59:44 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 04:59:44 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 04:59:44 INFO - u'mozbase': [u'target.common.tests.zip'], 04:59:44 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 04:59:44 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 04:59:44 INFO - u'web-platform': [u'target.common.tests.zip', 04:59:44 INFO - u'target.web-platform.tests.zip'], 04:59:44 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 04:59:44 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 04:59:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VO4h69AGST2XKTj92I1ebQ/artifacts/public/build/target.common.tests.zip 04:59:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VO4h69AGST2XKTj92I1ebQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:59:44 INFO - Fetch https://queue.taskcluster.net/v1/task/VO4h69AGST2XKTj92I1ebQ/artifacts/public/build/target.common.tests.zip into memory 04:59:45 INFO - Expected file size: 41751207 04:59:45 INFO - Obtained file size: 41751207 04:59:49 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 04:59:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VO4h69AGST2XKTj92I1ebQ/artifacts/public/build/target.common.tests.zip 04:59:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VO4h69AGST2XKTj92I1ebQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:59:49 INFO - Fetch https://queue.taskcluster.net/v1/task/VO4h69AGST2XKTj92I1ebQ/artifacts/public/build/target.common.tests.zip into memory 04:59:50 INFO - Expected file size: 41751207 04:59:50 INFO - Obtained file size: 41751207 04:59:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VO4h69AGST2XKTj92I1ebQ/artifacts/public/build/target.talos.tests.zip 04:59:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VO4h69AGST2XKTj92I1ebQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 04:59:55 INFO - Fetch https://queue.taskcluster.net/v1/task/VO4h69AGST2XKTj92I1ebQ/artifacts/public/build/target.talos.tests.zip into memory 04:59:56 INFO - Expected file size: 14403454 04:59:56 INFO - Obtained file size: 14403454 04:59:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:59:56 INFO - trying https://queue.taskcluster.net/v1/task/VO4h69AGST2XKTj92I1ebQ/artifacts/public/build/target.tar.bz2 04:59:56 INFO - Downloading https://queue.taskcluster.net/v1/task/VO4h69AGST2XKTj92I1ebQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 04:59:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VO4h69AGST2XKTj92I1ebQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 04:59:57 INFO - Downloaded 61577447 bytes. 04:59:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VO4h69AGST2XKTj92I1ebQ/artifacts/public/build/target.tar.bz2 04:59:57 INFO - mkdir: /builds/slave/test/properties 04:59:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:59:57 INFO - Writing to file /builds/slave/test/properties/build_url 04:59:57 INFO - Contents: 04:59:57 INFO - build_url:https://queue.taskcluster.net/v1/task/VO4h69AGST2XKTj92I1ebQ/artifacts/public/build/target.tar.bz2 04:59:57 INFO - Running post-action listener: _resource_record_post_action 04:59:57 INFO - Running post-action listener: set_extra_try_arguments 04:59:57 INFO - [mozharness: 2017-02-06 12:59:57.582451Z] Finished download-and-extract step (success) 04:59:57 INFO - [mozharness: 2017-02-06 12:59:57.582549Z] Running populate-webroot step. 04:59:57 INFO - Running pre-action listener: _resource_record_pre_action 04:59:57 INFO - Running main action method: populate_webroot 04:59:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:59:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:59:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:59:57 INFO - '--tppagecycles', 04:59:57 INFO - '7'], 04:59:57 INFO - 'tests': ['tsvgm']}}, 04:59:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:59:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:59:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:59:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:59:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:59:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:59:57 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:59:57 INFO - 'talos_options': ['--disable-e10s'], 04:59:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:59:57 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:59:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:59:57 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:59:57 INFO - 'talos_options': ['--disable-e10s'], 04:59:57 INFO - 'tests': ['damp', 'tps']}, 04:59:57 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:59:57 INFO - 'tests': ['damp', 'tps']}, 04:59:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:59:57 INFO - 'tests': ['dromaeo_dom']}, 04:59:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:59:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:59:57 INFO - 'tests': ['basic_compositor_video']}, 04:59:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:59:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:59:57 INFO - 'tests': ['a11yr', 04:59:57 INFO - 'ts_paint', 04:59:57 INFO - 'tpaint', 04:59:57 INFO - 'sessionrestore', 04:59:57 INFO - 'sessionrestore_no_auto_restore', 04:59:57 INFO - 'tabpaint']}, 04:59:57 INFO - 'other-e10s': {'tests': ['a11yr', 04:59:57 INFO - 'ts_paint', 04:59:57 INFO - 'tpaint', 04:59:57 INFO - 'sessionrestore', 04:59:57 INFO - 'sessionrestore_no_auto_restore', 04:59:57 INFO - 'tabpaint']}, 04:59:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:59:57 INFO - 'ts_paint', 04:59:57 INFO - 'tpaint', 04:59:57 INFO - 'sessionrestore', 04:59:57 INFO - 'sessionrestore_no_auto_restore', 04:59:57 INFO - 'tabpaint']}, 04:59:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:59:57 INFO - 'ts_paint', 04:59:57 INFO - 'tpaint', 04:59:57 INFO - 'sessionrestore', 04:59:57 INFO - 'sessionrestore_no_auto_restore', 04:59:57 INFO - 'tabpaint']}, 04:59:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:59:57 INFO - 'tests': ['a11yr', 04:59:57 INFO - 'ts_paint', 04:59:57 INFO - 'tpaint', 04:59:57 INFO - 'sessionrestore', 04:59:57 INFO - 'sessionrestore_no_auto_restore', 04:59:57 INFO - 'tabpaint']}, 04:59:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:59:57 INFO - 'tests': ['a11yr', 04:59:57 INFO - 'ts_paint', 04:59:57 INFO - 'tpaint', 04:59:57 INFO - 'sessionrestore', 04:59:57 INFO - 'sessionrestore_no_auto_restore', 04:59:57 INFO - 'tabpaint']}, 04:59:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:59:57 INFO - 'tests': ['tsvgx', 04:59:57 INFO - 'tsvgr_opacity', 04:59:57 INFO - 'tart', 04:59:57 INFO - 'tscrollx', 04:59:57 INFO - 'cart', 04:59:57 INFO - 'tsvg_static']}, 04:59:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:59:57 INFO - 'tsvgr_opacity', 04:59:57 INFO - 'tart', 04:59:57 INFO - 'tscrollx', 04:59:57 INFO - 'cart', 04:59:57 INFO - 'tsvg_static']}, 04:59:57 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:59:57 INFO - 'talos_options': ['--disable-e10s'], 04:59:57 INFO - 'tests': ['tp5o']}, 04:59:57 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:59:57 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:59:57 INFO - 'talos_options': ['--disable-e10s', 04:59:57 INFO - '--xperf_path', 04:59:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:59:57 INFO - 'tests': ['tp5n']}, 04:59:57 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:59:57 INFO - 'talos_options': ['--xperf_path', 04:59:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:59:57 INFO - 'tests': ['tp5n']}}, 04:59:57 INFO - 'talos.zip': {'path': '', 04:59:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:59:57 INFO - Running post-action listener: _resource_record_post_action 04:59:57 INFO - [mozharness: 2017-02-06 12:59:57.595811Z] Finished populate-webroot step (success) 04:59:57 INFO - [mozharness: 2017-02-06 12:59:57.595918Z] Running create-virtualenv step. 04:59:57 INFO - Running pre-action listener: _resource_record_pre_action 04:59:57 INFO - Running main action method: create_virtualenv 04:59:57 INFO - Creating virtualenv /builds/slave/test/build/venv 04:59:57 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:59:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:59:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:59:57 INFO - Using real prefix '/usr' 04:59:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:59:58 INFO - Installing distribute.............................................................................................................................................................................................done. 05:00:00 INFO - Installing pip.................done. 05:00:00 INFO - Return code: 0 05:00:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:00:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:00:00 INFO - Reading from file tmpfile_stdout 05:00:00 INFO - Output received: 05:00:00 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) 05:00:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:00:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:00:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:00 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 0x25c11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2932c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29303f0>, '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 0x2930cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29311a0>, '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': '20e666a3d4cfbb71505a330e000001b4-1486385980.116267-93126986', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:00:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:00:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:00:00 INFO - Using env: {'DISPLAY': ':0', 05:00:00 INFO - 'HOME': '/home/cltbld', 05:00:00 INFO - 'LANG': 'en_US.UTF-8', 05:00:00 INFO - 'LANGUAGE': 'en_US:en', 05:00:00 INFO - 'LOGNAME': 'cltbld', 05:00:00 INFO - 'MAIL': '/var/mail/cltbld', 05:00:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:00 INFO - 'MOZ_NO_REMOTE': '1', 05:00:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:00 INFO - 'NO_EM_RESTART': '1', 05:00:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:00:00 INFO - 'PWD': '/builds/slave/test', 05:00:00 INFO - 'SHELL': '/bin/bash', 05:00:00 INFO - 'SHLVL': '1', 05:00:00 INFO - 'TERM': 'linux', 05:00:00 INFO - 'TMOUT': '86400', 05:00:00 INFO - 'USER': 'cltbld', 05:00:00 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1486385980.116267-93126986', 05:00:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:00 INFO - '_': '/tools/buildbot/bin/python'} 05:00:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:00 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:00:00 INFO - Cleaning up... 05:00:00 INFO - Return code: 0 05:00:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:00:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:00:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:00 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 0x25c11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2932c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29303f0>, '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 0x2930cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29311a0>, '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': '20e666a3d4cfbb71505a330e000001b4-1486385980.116267-93126986', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:00:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:00:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:00:00 INFO - Using env: {'DISPLAY': ':0', 05:00:00 INFO - 'HOME': '/home/cltbld', 05:00:00 INFO - 'LANG': 'en_US.UTF-8', 05:00:00 INFO - 'LANGUAGE': 'en_US:en', 05:00:00 INFO - 'LOGNAME': 'cltbld', 05:00:00 INFO - 'MAIL': '/var/mail/cltbld', 05:00:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:00 INFO - 'MOZ_NO_REMOTE': '1', 05:00:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:00 INFO - 'NO_EM_RESTART': '1', 05:00:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:00:00 INFO - 'PWD': '/builds/slave/test', 05:00:00 INFO - 'SHELL': '/bin/bash', 05:00:00 INFO - 'SHLVL': '1', 05:00:00 INFO - 'TERM': 'linux', 05:00:00 INFO - 'TMOUT': '86400', 05:00:00 INFO - 'USER': 'cltbld', 05:00:00 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1486385980.116267-93126986', 05:00:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:00 INFO - '_': '/tools/buildbot/bin/python'} 05:00:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:00 INFO - Downloading/unpacking psutil>=3.1.1 05:00: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 05:00: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 05:00: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 05:00: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 05:00: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 05:00: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 05:00:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:00:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:00:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:00:02 INFO - Installing collected packages: psutil 05:00:02 INFO - Running setup.py install for psutil 05:00:02 INFO - building 'psutil._psutil_linux' extension 05:00:02 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:00:03 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:00:03 INFO - building 'psutil._psutil_posix' extension 05:00:03 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:00:03 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:00:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:00:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:00:03 INFO - Successfully installed psutil 05:00:03 INFO - Cleaning up... 05:00:03 INFO - Return code: 0 05:00:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:00:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:00:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2932c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29303f0>, '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 0x2930cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29311a0>, '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': '20e666a3d4cfbb71505a330e000001b4-1486385980.116267-93126986', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:00:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:00:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:00:03 INFO - Using env: {'DISPLAY': ':0', 05:00:03 INFO - 'HOME': '/home/cltbld', 05:00:03 INFO - 'LANG': 'en_US.UTF-8', 05:00:03 INFO - 'LANGUAGE': 'en_US:en', 05:00:03 INFO - 'LOGNAME': 'cltbld', 05:00:03 INFO - 'MAIL': '/var/mail/cltbld', 05:00:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:03 INFO - 'MOZ_NO_REMOTE': '1', 05:00:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:03 INFO - 'NO_EM_RESTART': '1', 05:00:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:00:03 INFO - 'PWD': '/builds/slave/test', 05:00:03 INFO - 'SHELL': '/bin/bash', 05:00:03 INFO - 'SHLVL': '1', 05:00:03 INFO - 'TERM': 'linux', 05:00:03 INFO - 'TMOUT': '86400', 05:00:03 INFO - 'USER': 'cltbld', 05:00:03 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1486385980.116267-93126986', 05:00:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:03 INFO - '_': '/tools/buildbot/bin/python'} 05:00:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:00:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:00:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:00:05 INFO - Installing collected packages: mozsystemmonitor 05:00:05 INFO - Running setup.py install for mozsystemmonitor 05:00:05 INFO - Successfully installed mozsystemmonitor 05:00:05 INFO - Cleaning up... 05:00:05 INFO - Return code: 0 05:00:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:00:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:00:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:00:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:05 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 0x25c11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2932c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29303f0>, '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 0x2930cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29311a0>, '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': '20e666a3d4cfbb71505a330e000001b4-1486385980.116267-93126986', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:00:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:00:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:00:05 INFO - Using env: {'DISPLAY': ':0', 05:00:05 INFO - 'HOME': '/home/cltbld', 05:00:05 INFO - 'LANG': 'en_US.UTF-8', 05:00:05 INFO - 'LANGUAGE': 'en_US:en', 05:00:05 INFO - 'LOGNAME': 'cltbld', 05:00:05 INFO - 'MAIL': '/var/mail/cltbld', 05:00:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:05 INFO - 'MOZ_NO_REMOTE': '1', 05:00:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:05 INFO - 'NO_EM_RESTART': '1', 05:00:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:00:05 INFO - 'PWD': '/builds/slave/test', 05:00:05 INFO - 'SHELL': '/bin/bash', 05:00:05 INFO - 'SHLVL': '1', 05:00:05 INFO - 'TERM': 'linux', 05:00:05 INFO - 'TMOUT': '86400', 05:00:05 INFO - 'USER': 'cltbld', 05:00:05 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1486385980.116267-93126986', 05:00:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:05 INFO - '_': '/tools/buildbot/bin/python'} 05:00:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:06 INFO - Downloading/unpacking jsonschema==2.5.1 05:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:00:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:08 INFO - Downloading functools32-3.2.3-2.tar.gz 05:00:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:00:08 INFO - warning: no files found matching '*.txt' 05:00:08 INFO - no previously-included directories found matching 'build' 05:00:08 INFO - no previously-included directories found matching 'dist' 05:00:08 INFO - no previously-included directories found matching '.git*' 05:00:08 INFO - Installing collected packages: jsonschema, functools32 05:00:08 INFO - Running setup.py install for functools32 05:00:08 INFO - warning: no files found matching '*.txt' 05:00:08 INFO - no previously-included directories found matching 'build' 05:00:08 INFO - no previously-included directories found matching 'dist' 05:00:08 INFO - no previously-included directories found matching '.git*' 05:00:08 INFO - Successfully installed jsonschema functools32 05:00:08 INFO - Cleaning up... 05:00:08 INFO - Return code: 0 05:00:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:00: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')]} 05:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00: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')]} 05:00:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00: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', '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 0x25c11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2932c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29303f0>, '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 0x2930cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29311a0>, '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': '20e666a3d4cfbb71505a330e000001b4-1486385980.116267-93126986', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:00: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:00: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 functools32==3.2.3-2 05:00:08 INFO - Using env: {'DISPLAY': ':0', 05:00:08 INFO - 'HOME': '/home/cltbld', 05:00:08 INFO - 'LANG': 'en_US.UTF-8', 05:00:08 INFO - 'LANGUAGE': 'en_US:en', 05:00:08 INFO - 'LOGNAME': 'cltbld', 05:00:08 INFO - 'MAIL': '/var/mail/cltbld', 05:00:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:08 INFO - 'MOZ_NO_REMOTE': '1', 05:00:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:08 INFO - 'NO_EM_RESTART': '1', 05:00:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:00:08 INFO - 'PWD': '/builds/slave/test', 05:00:08 INFO - 'SHELL': '/bin/bash', 05:00:08 INFO - 'SHLVL': '1', 05:00:08 INFO - 'TERM': 'linux', 05:00:08 INFO - 'TMOUT': '86400', 05:00:08 INFO - 'USER': 'cltbld', 05:00:08 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1486385980.116267-93126986', 05:00:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:08 INFO - '_': '/tools/buildbot/bin/python'} 05:00:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:00:08 INFO - Cleaning up... 05:00:08 INFO - Return code: 0 05:00:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:00: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')]} 05:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00: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')]} 05:00:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00: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', '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 0x25c11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2932c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29303f0>, '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 0x2930cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29311a0>, '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': '20e666a3d4cfbb71505a330e000001b4-1486385980.116267-93126986', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:00: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:00: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 blobuploader==1.2.4 05:00:08 INFO - Using env: {'DISPLAY': ':0', 05:00:08 INFO - 'HOME': '/home/cltbld', 05:00:08 INFO - 'LANG': 'en_US.UTF-8', 05:00:08 INFO - 'LANGUAGE': 'en_US:en', 05:00:08 INFO - 'LOGNAME': 'cltbld', 05:00:08 INFO - 'MAIL': '/var/mail/cltbld', 05:00:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:08 INFO - 'MOZ_NO_REMOTE': '1', 05:00:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:08 INFO - 'NO_EM_RESTART': '1', 05:00:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:00:08 INFO - 'PWD': '/builds/slave/test', 05:00:08 INFO - 'SHELL': '/bin/bash', 05:00:08 INFO - 'SHLVL': '1', 05:00:08 INFO - 'TERM': 'linux', 05:00:08 INFO - 'TMOUT': '86400', 05:00:08 INFO - 'USER': 'cltbld', 05:00:08 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1486385980.116267-93126986', 05:00:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:08 INFO - '_': '/tools/buildbot/bin/python'} 05:00:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:09 INFO - Downloading/unpacking blobuploader==1.2.4 05:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:11 INFO - Downloading blobuploader-1.2.4.tar.gz 05:00:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:00:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:00:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:00:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:00:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:11 INFO - Downloading docopt-0.6.1.tar.gz 05:00:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:00:11 INFO - Installing collected packages: blobuploader, requests, docopt 05:00:11 INFO - Running setup.py install for blobuploader 05:00:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:00:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:00:11 INFO - Running setup.py install for requests 05:00:12 INFO - Running setup.py install for docopt 05:00:12 INFO - Successfully installed blobuploader requests docopt 05:00:12 INFO - Cleaning up... 05:00:12 INFO - Return code: 0 05:00:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:00:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:00:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:12 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 0x25c11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2932c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29303f0>, '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 0x2930cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29311a0>, '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': '20e666a3d4cfbb71505a330e000001b4-1486385980.116267-93126986', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:00:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:00:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:00:12 INFO - Using env: {'DISPLAY': ':0', 05:00:12 INFO - 'HOME': '/home/cltbld', 05:00:12 INFO - 'LANG': 'en_US.UTF-8', 05:00:12 INFO - 'LANGUAGE': 'en_US:en', 05:00:12 INFO - 'LOGNAME': 'cltbld', 05:00:12 INFO - 'MAIL': '/var/mail/cltbld', 05:00:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:12 INFO - 'MOZ_NO_REMOTE': '1', 05:00:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:12 INFO - 'NO_EM_RESTART': '1', 05:00:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:00:12 INFO - 'PWD': '/builds/slave/test', 05:00:12 INFO - 'SHELL': '/bin/bash', 05:00:12 INFO - 'SHLVL': '1', 05:00:12 INFO - 'TERM': 'linux', 05:00:12 INFO - 'TMOUT': '86400', 05:00:12 INFO - 'USER': 'cltbld', 05:00:12 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1486385980.116267-93126986', 05:00:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:12 INFO - '_': '/tools/buildbot/bin/python'} 05:00:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:00:12 INFO - Running setup.py (path:/tmp/pip-F_iweq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:00:12 INFO - Running setup.py (path:/tmp/pip-4P_YDe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:00:12 INFO - Running setup.py (path:/tmp/pip-L1sbhl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:00:12 INFO - Running setup.py (path:/tmp/pip-asWzpr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:00:12 INFO - Running setup.py (path:/tmp/pip-tmjsWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:00:13 INFO - Running setup.py (path:/tmp/pip-3h0WK5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:00:13 INFO - Running setup.py (path:/tmp/pip-KFyLoS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:00:13 INFO - Running setup.py (path:/tmp/pip-Of9ToD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:00:13 INFO - Running setup.py (path:/tmp/pip-7eRpAB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:00:13 INFO - Running setup.py (path:/tmp/pip-ukEnSE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:00:13 INFO - Running setup.py (path:/tmp/pip-IMhYZx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:00:13 INFO - Running setup.py (path:/tmp/pip-l9KDuY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:00:13 INFO - Running setup.py (path:/tmp/pip-4yiybx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:00:13 INFO - Running setup.py (path:/tmp/pip-OFOX9N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:00:13 INFO - Running setup.py (path:/tmp/pip-iV27M0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:00:13 INFO - Running setup.py (path:/tmp/pip-urpved-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:00:13 INFO - Running setup.py (path:/tmp/pip-gKHbpS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:00:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:00:13 INFO - Running setup.py install for manifestparser 05:00:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:00:14 INFO - Running setup.py install for mozcrash 05:00:14 INFO - Running setup.py install for mozdebug 05:00:14 INFO - Running setup.py install for mozdevice 05:00:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:00:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:00:14 INFO - Running setup.py install for mozfile 05:00:14 INFO - Running setup.py install for mozhttpd 05:00:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:00:14 INFO - Running setup.py install for mozinfo 05:00:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:00:14 INFO - Running setup.py install for mozInstall 05:00:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:00:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:00:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:00:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:00:14 INFO - Running setup.py install for mozleak 05:00:14 INFO - Running setup.py install for mozlog 05:00:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:00:14 INFO - Running setup.py install for moznetwork 05:00:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:00:15 INFO - Running setup.py install for mozprocess 05:00:15 INFO - Running setup.py install for mozprofile 05:00:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:00:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:00:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:00:15 INFO - Running setup.py install for mozrunner 05:00:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:00:15 INFO - Running setup.py install for mozscreenshot 05:00:15 INFO - Running setup.py install for moztest 05:00:15 INFO - Running setup.py install for mozversion 05:00:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:00:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:00:15 INFO - Cleaning up... 05:00:15 INFO - Return code: 0 05:00:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:00:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:00:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:15 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 0x25c11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2932c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29303f0>, '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 0x2930cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29311a0>, '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': '20e666a3d4cfbb71505a330e000001b4-1486385980.116267-93126986', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:00:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:00:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:00:15 INFO - Using env: {'DISPLAY': ':0', 05:00:15 INFO - 'HOME': '/home/cltbld', 05:00:15 INFO - 'LANG': 'en_US.UTF-8', 05:00:15 INFO - 'LANGUAGE': 'en_US:en', 05:00:15 INFO - 'LOGNAME': 'cltbld', 05:00:15 INFO - 'MAIL': '/var/mail/cltbld', 05:00:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:15 INFO - 'MOZ_NO_REMOTE': '1', 05:00:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:15 INFO - 'NO_EM_RESTART': '1', 05:00:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:00:15 INFO - 'PWD': '/builds/slave/test', 05:00:15 INFO - 'SHELL': '/bin/bash', 05:00:15 INFO - 'SHLVL': '1', 05:00:15 INFO - 'TERM': 'linux', 05:00:15 INFO - 'TMOUT': '86400', 05:00:15 INFO - 'USER': 'cltbld', 05:00:15 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1486385980.116267-93126986', 05:00:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:15 INFO - '_': '/tools/buildbot/bin/python'} 05:00:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:00:15 INFO - Running setup.py (path:/tmp/pip-68h_Om-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:00:16 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:00:16 INFO - Running setup.py (path:/tmp/pip-LFL7gV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:00:16 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)) 05:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:00:16 INFO - Running setup.py (path:/tmp/pip-TWiFCV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:00:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:00:16 INFO - Running setup.py (path:/tmp/pip-cYtBW8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:00:16 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)) 05:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:00:16 INFO - Running setup.py (path:/tmp/pip-fXO9wu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:00:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:00:16 INFO - Running setup.py (path:/tmp/pip-1Moa0H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:00:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:00:16 INFO - Running setup.py (path:/tmp/pip-hXqVOD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:00:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:00:16 INFO - Running setup.py (path:/tmp/pip-uMhIn1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:00:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:00:16 INFO - Running setup.py (path:/tmp/pip-xWp2Eu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:00:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:00:16 INFO - Running setup.py (path:/tmp/pip-dmSjZz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:00:16 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)) 05:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:00:16 INFO - Running setup.py (path:/tmp/pip-YFWlZz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:00:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:00:16 INFO - Running setup.py (path:/tmp/pip-q65HIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:00:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:00:16 INFO - Running setup.py (path:/tmp/pip-3lV56W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:00:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:00:16 INFO - Running setup.py (path:/tmp/pip-X0HrOq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:00:16 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)) 05:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:00:16 INFO - Running setup.py (path:/tmp/pip-uBFy8G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:00:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:00:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:00:17 INFO - Running setup.py (path:/tmp/pip-eoWIGo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:00:17 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)) 05:00:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:00:17 INFO - Running setup.py (path:/tmp/pip-a_cT7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:00:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:00:17 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)) 05:00:17 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)) 05:00:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:00:17 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)) 05:00:17 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)) 05:00:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:00:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:19 INFO - Downloading blessings-1.6.tar.gz 05:00:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:00:19 INFO - Installing collected packages: blessings 05:00:19 INFO - Running setup.py install for blessings 05:00:19 INFO - Successfully installed blessings 05:00:19 INFO - Cleaning up... 05:00:19 INFO - Return code: 0 05:00:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:00:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:00:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:00:19 INFO - Reading from file tmpfile_stdout 05:00:19 INFO - Current package versions: 05:00:19 INFO - argparse == 1.2.1 05:00:19 INFO - blessings == 1.6 05:00:19 INFO - blobuploader == 1.2.4 05:00:19 INFO - docopt == 0.6.1 05:00:19 INFO - functools32 == 3.2.3-2 05:00:19 INFO - jsonschema == 2.5.1 05:00:19 INFO - manifestparser == 1.1 05:00:19 INFO - mozInstall == 1.12 05:00:19 INFO - mozcrash == 1.0 05:00:19 INFO - mozdebug == 0.1 05:00:19 INFO - mozdevice == 0.49 05:00:19 INFO - mozfile == 1.2 05:00:19 INFO - mozhttpd == 0.7 05:00:19 INFO - mozinfo == 0.9 05:00:19 INFO - mozleak == 0.1 05:00:19 INFO - mozlog == 3.4 05:00:19 INFO - moznetwork == 0.27 05:00:19 INFO - mozprocess == 0.24 05:00:19 INFO - mozprofile == 0.28 05:00:19 INFO - mozrunner == 6.13 05:00:19 INFO - mozscreenshot == 0.1 05:00:19 INFO - mozsystemmonitor == 0.3 05:00:19 INFO - moztest == 0.8 05:00:19 INFO - mozversion == 1.4 05:00:19 INFO - psutil == 3.1.1 05:00:19 INFO - requests == 1.2.3 05:00:19 INFO - wsgiref == 0.1.2 05:00:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:00:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:00:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:00:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:19 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 0x25c11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2932c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29303f0>, '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 0x2930cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29311a0>, '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': '20e666a3d4cfbb71505a330e000001b4-1486385980.116267-93126986', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:00:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:00:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:00:19 INFO - Using env: {'DISPLAY': ':0', 05:00:19 INFO - 'HOME': '/home/cltbld', 05:00:19 INFO - 'LANG': 'en_US.UTF-8', 05:00:19 INFO - 'LANGUAGE': 'en_US:en', 05:00:19 INFO - 'LOGNAME': 'cltbld', 05:00:19 INFO - 'MAIL': '/var/mail/cltbld', 05:00:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:19 INFO - 'MOZ_NO_REMOTE': '1', 05:00:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:19 INFO - 'NO_EM_RESTART': '1', 05:00:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:00:19 INFO - 'PWD': '/builds/slave/test', 05:00:19 INFO - 'SHELL': '/bin/bash', 05:00:19 INFO - 'SHLVL': '1', 05:00:19 INFO - 'TERM': 'linux', 05:00:19 INFO - 'TMOUT': '86400', 05:00:19 INFO - 'USER': 'cltbld', 05:00:19 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1486385980.116267-93126986', 05:00:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:19 INFO - '_': '/tools/buildbot/bin/python'} 05:00:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:00:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:00:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:00:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:00:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:00:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:00:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:00:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:00:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:00:19 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:00:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:00:19 INFO - Cleaning up... 05:00:19 INFO - Return code: 0 05:00:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:00:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:00:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:00:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2932c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29303f0>, '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 0x2930cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29311a0>, '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': '20e666a3d4cfbb71505a330e000001b4-1486385980.116267-93126986', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:00:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:00:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:00:19 INFO - Using env: {'DISPLAY': ':0', 05:00:19 INFO - 'HOME': '/home/cltbld', 05:00:19 INFO - 'LANG': 'en_US.UTF-8', 05:00:19 INFO - 'LANGUAGE': 'en_US:en', 05:00:19 INFO - 'LOGNAME': 'cltbld', 05:00:19 INFO - 'MAIL': '/var/mail/cltbld', 05:00:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:19 INFO - 'MOZ_NO_REMOTE': '1', 05:00:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:19 INFO - 'NO_EM_RESTART': '1', 05:00:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:00:19 INFO - 'PWD': '/builds/slave/test', 05:00:19 INFO - 'SHELL': '/bin/bash', 05:00:19 INFO - 'SHLVL': '1', 05:00:19 INFO - 'TERM': 'linux', 05:00:19 INFO - 'TMOUT': '86400', 05:00:19 INFO - 'USER': 'cltbld', 05:00:19 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1486385980.116267-93126986', 05:00:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:19 INFO - '_': '/tools/buildbot/bin/python'} 05:00:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:00:20 INFO - Cleaning up... 05:00:20 INFO - Return code: 0 05:00:20 INFO - Running post-action listener: _resource_record_post_action 05:00:20 INFO - Running post-action listener: _start_resource_monitoring 05:00:20 INFO - Starting resource monitoring. 05:00:20 INFO - [mozharness: 2017-02-06 13:00:20.191838Z] Finished create-virtualenv step (success) 05:00:20 INFO - [mozharness: 2017-02-06 13:00:20.192322Z] Running install step. 05:00:20 INFO - Running pre-action listener: _resource_record_pre_action 05:00:20 INFO - Running main action method: install 05:00:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:00:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:00:20 INFO - Reading from file tmpfile_stdout 05:00:20 INFO - Detecting whether we're running mozinstall >=1.0... 05:00:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:00:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:00:20 INFO - Reading from file tmpfile_stdout 05:00:20 INFO - Output received: 05:00:20 INFO - Usage: mozinstall [options] installer 05:00:20 INFO - Options: 05:00:20 INFO - -h, --help show this help message and exit 05:00:20 INFO - -d DEST, --destination=DEST 05:00:20 INFO - Directory to install application into. [default: 05:00:20 INFO - "/builds/slave/test"] 05:00:20 INFO - --app=APP Application being installed. [default: firefox] 05:00:20 INFO - mkdir: /builds/slave/test/build/application 05:00:20 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'] 05:00:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:00:37 INFO - Reading from file tmpfile_stdout 05:00:37 INFO - Output received: 05:00:37 INFO - /builds/slave/test/build/application/firefox/firefox 05:00:37 INFO - Running post-action listener: _resource_record_post_action 05:00:37 INFO - [mozharness: 2017-02-06 13:00:37.970022Z] Finished install step (success) 05:00:37 INFO - [mozharness: 2017-02-06 13:00:37.970363Z] Running run-tests step. 05:00:37 INFO - Running pre-action listener: _resource_record_pre_action 05:00:37 INFO - Running main action method: run_tests 05:00:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:00:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:00:37 INFO - Python 2.7.3 05:00:37 INFO - Return code: 0 05:00:37 INFO - grabbing minidump binary from tooltool 05:00:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:00:37 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 0x29303f0>, '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 0x2930cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29311a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:00:37 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:00:37 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:00:37 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:00:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:00:38 INFO - Return code: 0 05:00:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:00:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:00:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:00:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:00:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:00:38 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/VO4h69AGST2XKTj92I1ebQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:00:38 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/VO4h69AGST2XKTj92I1ebQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-015 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:00:38 INFO - Using env: {'DISPLAY': ':0', 05:00:38 INFO - 'HOME': '/home/cltbld', 05:00:38 INFO - 'LANG': 'en_US.UTF-8', 05:00:38 INFO - 'LANGUAGE': 'en_US:en', 05:00:38 INFO - 'LOGNAME': 'cltbld', 05:00:38 INFO - 'MAIL': '/var/mail/cltbld', 05:00:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:00:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:00:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:38 INFO - 'MOZ_NO_REMOTE': '1', 05:00:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:00:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:38 INFO - 'NO_EM_RESTART': '1', 05:00:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:00:38 INFO - 'PWD': '/builds/slave/test', 05:00:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:00:38 INFO - 'SHELL': '/bin/bash', 05:00:38 INFO - 'SHLVL': '1', 05:00:38 INFO - 'TERM': 'linux', 05:00:38 INFO - 'TMOUT': '86400', 05:00:38 INFO - 'USER': 'cltbld', 05:00:38 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1486385980.116267-93126986', 05:00:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:38 INFO - '_': '/tools/buildbot/bin/python'} 05:00:38 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/VO4h69AGST2XKTj92I1ebQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:00:38 INFO - mozversion application_buildid: 20170206115502 05:00:38 INFO - mozversion application_changeset: c5621cb6f9075d731ccb28dcf20dd29deae2bddd 05:00:38 INFO - mozversion application_display_name: Nightly 05:00:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:00:38 INFO - mozversion application_name: Firefox 05:00:38 INFO - mozversion application_remotingname: firefox 05:00:38 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:00:38 INFO - mozversion application_vendor: Mozilla 05:00:38 INFO - mozversion application_version: 54.0a1 05:00:38 INFO - mozversion platform_buildid: 20170206115502 05:00:38 INFO - mozversion platform_changeset: c5621cb6f9075d731ccb28dcf20dd29deae2bddd 05:00:38 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:00:38 INFO - mozversion platform_version: 54.0a1 05:00:38 INFO - using testdate: 1486386038 05:00:38 INFO - actual date: 1486386038 05:00:38 INFO - starting webserver on 'localhost:51859' 05:00:38 INFO - SUITE-START | Running 2 tests 05:00:38 INFO - TEST-START | dromaeo_css 05:00:38 INFO - operating with platform_type : linux_ 05:00:38 INFO - Initialising browser for dromaeo_css test... 05:00:38 INFO - TEST-INFO | started process 12682 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwjL1JI/profile http://localhost:51859/getInfo.html) 05:00:41 INFO - PROCESS | 12682 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 05:00:42 INFO - PROCESS | 12682 | __metrics Screen width/height:1600/1200 05:00:42 INFO - PROCESS | 12682 | colorDepth:24 05:00:42 INFO - PROCESS | 12682 | Browser inner width/height: 1024/697 05:00:42 INFO - PROCESS | 12682 | __metrics 05:00:42 INFO - PROCESS | 12682 | 1486386042919 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 05:00:43 INFO - PROCESS | 12682 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:00:43 INFO - PROCESS | 12682 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:00:44 INFO - TEST-INFO | 12682: exit 0 05:00:44 INFO - Browser initialized. 05:00:44 INFO - Running cycle 1/1 for dromaeo_css test... 05:00:44 INFO - TEST-INFO | started process 12765 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwjL1JI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:00:56 INFO - PROCESS | 12765 | RSS: Main: 148619264 05:00:56 INFO - PROCESS | 12765 | 05:03:57 INFO - PROCESS | 12765 | Cycle 1(1): loaded http://localhost:51859/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51859/tests/dromaeo/cssquery-ext.html) 05:03:58 INFO - PROCESS | 12765 | RSS: Main: 277676032 05:03:58 INFO - PROCESS | 12765 | 05:05:45 INFO - PROCESS | 12765 | ************************* 05:05:45 INFO - PROCESS | 12765 | A coding exception was thrown and uncaught in a Task. 05:05:45 INFO - PROCESS | 12765 | 05:05:45 ERROR - PROCESS | 12765 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:05:45 INFO - PROCESS | 12765 | Full stack: 05:05:45 INFO - PROCESS | 12765 | ************************* 05:07:01 INFO - PROCESS | 12765 | Cycle 1(1): loaded http://localhost:51859/tests/dromaeo/cssquery-ext.html (next: http://localhost:51859/tests/dromaeo/cssquery-jquery.html) 05:07:02 INFO - PROCESS | 12765 | RSS: Main: 256942080 05:07:02 INFO - PROCESS | 12765 | 05:10:04 INFO - PROCESS | 12765 | Cycle 1(1): loaded http://localhost:51859/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51859/tests/dromaeo/cssquery-mootools.html) 05:10:04 INFO - PROCESS | 12765 | RSS: Main: 213745664 05:10:04 INFO - PROCESS | 12765 | 05:13:06 INFO - PROCESS | 12765 | Cycle 1(1): loaded http://localhost:51859/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51859/tests/dromaeo/cssquery-prototype.html) 05:13:07 INFO - PROCESS | 12765 | RSS: Main: 227004416 05:13:07 INFO - PROCESS | 12765 | 05:16:09 INFO - PROCESS | 12765 | Cycle 1(1): loaded http://localhost:51859/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51859/tests/dromaeo/cssquery-yui.html) 05:16:10 INFO - PROCESS | 12765 | RSS: Main: 191160320 05:16:10 INFO - PROCESS | 12765 | 05:19:13 INFO - PROCESS | 12765 | Cycle 1(1): loaded http://localhost:51859/tests/dromaeo/cssquery-yui.html (next: http://localhost:51859/tests/dromaeo/cssquery-dojo.html) 05:19:13 INFO - PROCESS | 12765 | RSS: Main: 284446720 05:19:13 INFO - PROCESS | 12765 | 05:19:13 INFO - PROCESS | 12765 | __start_tp_report 05:19:13 INFO - PROCESS | 12765 | _x_x_mozilla_page_load 05:19:13 INFO - PROCESS | 12765 | _x_x_mozilla_page_load_details 05:19:13 INFO - PROCESS | 12765 | |i|pagename|runs| 05:19:13 INFO - PROCESS | 12765 | |0;dojo.html;3189.5375170600264;3210.2134976930647;3212.8232947187894;3230.644629090801;3264.118687954251;5148.330717006784;5193.792248310073;5271.367435907687;5306;5329.680219186846;5260.973695131529;5276.050310944029;5287.762050707718;5326.360836699601;5350.27771250882;4768.403949506303;4853.951460485403;4857.927131093036;4871.780769865347;4920.065187614342;4906.484819093997;4923.040007198598;4948.1093403187415;4972.43087741728;4976.3530741003615;4785.736784476852;4787.377640906678;4808.3027960945465;4809.855704328858;4824.662273640846;4830.516948305177;4831.106245344622;4848.903021939576;4917.286993385939;4935.3090567320605;4795.928061079052;4818.59041981432;4820.373351464323;4840.201366774478;4868.123737727207;5120.436751957319;5161.561267292284;5170.224466330043;5356.758945847446;5361.383440904307;5604;5621.606487545873;5629.662220266797;5630.971845140789;5637.210790489335;5647.887042259173;5660.632058916199;5664.235328230719;5667.886642267132;5671.234383358235;5269.947300527022;5320.14877619579;5381.623286369995;5431.2396264522995;5431.8098866539485;5857.619254748428;5891.734871930774;5913.822585322448;5918.2898052234;5926.525877929756;5519.972400137974;5543.6396634218645;5558.944410555923;5627.043402621564;5630.6058575900115;5633.549316054706;5645.5483561314995;5652.265205523256;5752.050911599539;5754.251947246831;5699.202111704365;5700.030994730822;5702.971485142548;5708.65748055118;5725;5576.358718747396;5622.690752008597;5712.914306285409;5713.714314284269;5718.714064296769;4399.450068741407;4401.053773438726;4423.6903416760515;4431.889202769957;4466.731996080245;3958.426028225891;3958.5645578986287;3959.4456776051375;3974.6621537169663;3991;5234.110201265794;5339.733013349317;5343.492368225013;5347.598930080259;5348.491893270133;5602.187682785973;5683.062294721325;5702.686352250583;5716.42835716425;5805.216295800013;5373.167159090347;5374.811881584125;5377.247185394048;5379.811706590251;5384.138537833927;4928;4940.283658869444;4948.703077815343;4955.40535135786;5002.57478114357;5695.288088988877;5708.743106560131;5751.59738818287;5864.120381942743;5901.793437229677;5666.46168613981;5671.092625180117;5675.7445914933105;5701.888131814422;5720.656760594377;5856.0630299151935;5904.911426328523;5939.910901336397;5940.940590594038;5941.1088336749835;5467.972660136674;5526.336839579276;5594.580406469449;5618.213450116905;5618.887622247614;5790.9710451449155;5803.042497987784;5803.680797556175;5829.47534721877;5851;5592.468715472024;5600.60795744294;5609.1305847593685;5616.0452723038;5668.51817595509;5435.83692489226;5459.535939445192;5463;5576.302962129734;5582.748776305158;5613.158026296088;5645.887082258249;5652.236948012131;5660.518855897295;5702.144678298288;5635.633683810704;5658.377578466448;5674.74463649145;5696.572757043155;5699.145128230799;5347.0375332440535;5463.617546771847;5475.479829416199;5526.861828454321;5532.446755324436 05:19:13 INFO - PROCESS | 12765 | |1;ext.html;541.5505130741484;558.3272157050754;569.5529009727364;569.82050654044;581.226968132384;31986.520202196956;44713;45188.54811451889;45378.54621453785;48725.51274487254;45264.773676131575;45700.3144952826;45741.313880291826;45767.313490297674;45776.85557861055;7686.116096648873;8884.600192991298;9066.592003359832;9069.319801014917;9069.410488318272;7766.883496747553;10756.19328550362;11008.504617292201;11020.393878336688;11358.772824543505;10574.365538067741;10621.681349559525;10636.46817659114;10661;10687.946560267188;10582.576696932114;10617.73455663607;10644.840327395095;10651.25441219115;10651.360918344886;10478.318909270873;10515.369077855354;10531.104856087242;10541.104006159485;10543.156547476183;44463;44506.33240501395;44803.32795008078;44804.327935081;44845;4059.4519739835337;4103.589641035903;4113.732607380511;4132.793360331972;4191.72753771007;28310.71689283122;28687.85656071727;28771;28861.56707649387;28973.42053158946;3607.4769158472136;3725.0873535983587;3731.6454936781233;3751.962480375216;3868.7485313454536;211707.18049736525;213295;213305.9334703332;213724;215139;58716.31180855111;58766;59367.703161483914;59623.403765962656;59677.701611492535;61597.38402615916;61951;61997.690011549654;62079.379206208265;62363;16017.279222435018;16209.83790162107;16217;16224.918875405547;16269.267882945296;12802.80795788064;12862.678433039062;12867.871321286855;12881.420336084899;12917.418716157796;15314.693706126038;16490.75263871043;16517;16540.586485337964;16561.83438165627;6162.291336496271;6164.753409863555;6384.648844313608;6394.840128996812;6487.481001519962;909.486140330711;921.6129225725211;932.0958670090001;932.6316105138433;935.3452583191793;29063.709362906102;30081;30320.393592128035;30399;30422.69577304243;1091.6888686724403;1114.7324642085841;1117.3016864459712;1143.331151276496;1220.4751956658545;15378;15672.216389180723;15848.366065357488;15896.682066358608;16360.482496263123;473737;481368;481815;482635;483076;61759.382406176264;61889.071663925075;61892.69053654703;62024;62158;1369.3906211735682;1444.6243976566168;1448.9058211216447;1449.0508716790519;1454.941802327916;29012;30250;30281.24296892595;30812.53781193239;30917.69082309148;38744.2251154981;38804.6119538801;39100;39129;39134.412983804694;375170;380091;380663;380788;382172;38490.23019539649;39364.803175983936;39441.40837887376;39910.2017959645;39933;44307;44897.55102448934;45346.77326613346;45728.54271457243;46022.309665354376;37912;38613.80693096516;38950.40494860005;39759.40360894531;40743.7962810184;37754.149972806765;38475.615243848326;39078;40042;40403;35464;39970.200595987335;40037.79981100076;40188;40323.1935361297;29469;31812.36375272435;32198.83900580482;32483;32628.673713262564;24406.26781196567;25223.36941576475;25294.747052529237;25586.336888102214;25733.485330292915 05:19:13 INFO - PROCESS | 12765 | |2;jquery.html;383.3674437178657;403.33248473775893;423.8347044652585;425.73391630231106;429.39240974021743;13503.594892153227;15065.171415572138;19257.99999999998;20162.59674806503;20483;20571.691424628643;20709.482262943435;21057.47356316093;21060.684089738665;21323;5704.172894930232;5817.214676018747;5871.9412805871825;5923.940760592403;5980.79067232647;3733.7199710021723;3917.4515567820386;5806.332271788735;5883.617564858292;5907.232059832238;3942.4086387041884;3948.7828169450668;3960.544537378195;4135.04893874409;6593.076969224312;6647.900281495781;6653.866922661544;6657.9334206657795;6677.298883617247;6680.966595167018;5185.274061631375;5413.729313534347;5443.564514838803;5483.451654834525;5487.533559647395;14170.433182672681;14253.073550219202;14254.714905701829;14340.856591434056;14445.277736113258;2510.924672259835;2550.4006558458746;2596.9870150649126;2601.5447296722996;2619.620155077503;9686;10425.322354046963;10435.234143686674;10572;10813.18901082422;1753.8070812210647;1815.48258746258;1838.6598479281377;1839.760831091963;1843.4184510329671;85397;86580.03930989321;86745;86939;87995;11452.682941461671;11541.711457213469;11676.532938682527;11739;12371.938140309421;17456.127193640266;17472.126393680264;17487.825121748872;17524.91237543804;17548.64902701939;8141.959290203511;8242.2581967622;8324.500529968222;8393.24460798531;8443.155684431507;7644.655990480442;7648.34989025939;7667.463277570628;7996.400269979775;8003.9599802001785;5023.02051100032;5127.66670166438;5139.177731562932;5223.843284701465;5299.6025298102795;2099.2337796704396;2125.776793436698;2160.967585486219;2161.4812445013085;2232.319142661504;985.3447457440865;990.2968892086556;1004.1866088468364;1013.2653825976108;1013.8073765984586;19928;20294.18823247083;20320.69518957217;20551.691724624143;20764.169433222803;975.8048390321964;979.1041197304529;979.5249304087512;994.1847684898459;1001.9949900250452;10562.419066951237;10649.574017039387;11059.22585419013;11085.889141108648;11670.533178672928;620886;632034;666214;673618;675471;107784;109233;110724.4463777676;111724.4413777926;114362.42818785853;1092.224520590374;1112.6495154026618;1125.876153623101;1131.7623299107115;1142.4915912418894;17291.9249690038;17754.733678995082;18416.90791546034;18562.164702588685;18615.53461163482;41038.9273916703;41595.376069358375;45907;47356.05287894154;47357.76321118372;57898;60265.39734602598;61964.18393976569;62221.20004599713;63979.68010160106;8893.911060889308;8935.955320223356;8939.910600894167;9007.774805629911;9228.676996305365;11612.21306886358;12606.180598261084;13715.725685486434;13732;14159.929200353932;11502.309861408343;11523.423828808694;11534.1926065178;11948.940255298668;12290.692732681755;11467.770644587228;11477.5897061618;11803.114766392726;11894.940525297665;12113.515459381526;11363;11856.407179641155;11883.821742673694;12078.758424831278;12462.875371246171;8826.691065812665;8886.37795354319;8941.195292423714;9105.954470227607;9331.673391431268;9079.137481939206;10878.74863006862;11557.479913404086;11562.190646654653;11834.76330473403 05:19:13 INFO - PROCESS | 12765 | |3;mootools.html;1402.9508967186143;1418.1774570748967;1428.378655284951;1430.5207755401946;1439.1724758263997;8441.240288374052;8838.292936565076;8843.159899809507;8846.823063538724;8864.113588641148;8548.14518548145;8780.868286975701;8837.734867953972;9022.86465703015;9027.413218140833;2275.0444813178424;2303.366574192094;2308.203669733939;2308.68832707584;2309.157157637467;1957.2171131547352;2027.7262569553143;2215.8892055397246;2260.5026894083358;2260.6156953317977;2181.770914054025;2244.147224054857;2253.4141123307977;2258.390234636647;2266.648669456237;2190.3319487556287;2191.244020812817;2217.1796435318956;2217.84475086744;2223.9332820015425;2211.6129677306567;2217.9112835486562;2273.579387813243;2274.749777524471;2276.5674521840797;8738.30093592511;8785.165409286172;8794.252488538483;8804.955975220148;8810.911890881072;5068.670536415121;5193.68837869729;5195.064888320101;5198.870028249286;5199.090159222121;3225.8387080646107;3266.8529916153593;3328.21786880083;3335.983320083408;3363.882264120744;1238.907081968847;1242.0994778785398;1272.5100836178046;1306.3990564340415;1306.5818937939864;11871.169018168732;11999.220050696764;12021.699457513545;12075.335856527887;12116.757664846742;4229.97885010573;4431.313146462304;4494.797734101973;4509.188346097734;4609.147307748078;9486.762830929281;9514.809703805886;9517.143457088896;9517.191038761783;9518.190953768868;5162.6386152968935;5163.277141200235;5163.741812909339;5166.974165129151;5169.25045868347;4564.269716845289;4610.05493873755;4695.154872122982;4742.170120228946;4818.156822556039;3569.714422846166;3636.5454318210222;3702.777833330009;3718;3780.281746468162;1012.089119792193;1041.094248004241;1093.1307464236245;1094.8631421072366;1109.9611513596985;783.804048987753;785.6229010075195;808.7331180710469;816.3877092180865;822.7943014246439;5531.778728850882;5587.273654424899;5710.828675139753;5738.139279108083;5876.6180198286975;996.7009897030862;1012.1447376966452;1018.7045756730613;1034.5189486888632;1065.1532032034552;3618.16782140104;3708.49935258742;3751.793651349202;3927.8036098194975;3929.8821035368983;10223.488825558692;10542.841857372145;10614.89385106139;10626.73433164177;10632.415217162976;10293.639722609672;10340.482975851177;10498.265121441425;10583.57665693379;10594.099501542301;7951.801204969922;8116.431849770577;8127.268545830903;8130.268275855083;8134.186581341818;5422.674639521641;5483.2323474712775;5609.691466969192;5650.63270887391;5797.8550536236935;9500.239980801382;9520.285978551497;9544.42733435996;9556.808863822545;9642.855357169788;9393.295502837178;9560.521973901416;9677.661281855102;9707.611695532381;9737.951310243687;7264.091988501437;7507.962460187664;7565.2812982766545;7583.582902940391;7751.8837217442915;8259.21537453941;8336.791580210544;8378.455400398954;8403.117672644285;8419.663213471638;7406.518576292524;7462.141853686679;7478;7484.401247900264;7577.962110189414;7213.6753846076;7408.296211859864;7475.551466912003;7484;7491.3632341251605;6398.680065996775;6609.537332386687;6623.834404139935;6654.800355989328;6661.666916654245;5000.224965130411;5135.92296115566;5178.223266509903;5181.248718935809;5402.000629883484;5093.6179786516905;5095.133827249302;5133.6919784813035;5215.608829337739;5416 05:19:13 INFO - PROCESS | 12765 | |4;prototype.html;366.52168919559966;381.13862670364966;382.3996325768543;392.66034879828936;400.8096154326695;5049.798008079672;5190.221466779984;5279.683219006863;5290.095565596387;5295.232191332255;5062.341895553573;5141.562967147797;5147.613928955325;5174.172132458807;5207.6875387476775;4198.286291330481;4207.516135644394;4215.3255479123345;4225.19721252961;4238.516519218279;3939.704522160835;4017.8794636160815;4199.664026877857;4220.746755194683;4228.743867222237;4177.436046133778;4203.558626344236;4209.705320627558;4212.304969680014;4222.472190976128;4166;4194.2450358935375;4200.495940487131;4202.873913782576;4214.1247145020325;3822.3310920588788;3835.3096442640312;3838.2707285615643;3839.2897313996723;3845.3849383258816;4887.877803054952;4993.925091123636;5035.92446113305;5081.5263573563625;5099.6685215460875;4821.204501257288;4845.53967373099;4848.054629347279;4852.805887764485;4859;5337.704786941614;5511.58663100269;5511.917321240185;5515.669059856381;5520.530754885839;4112.177564487085;4159.355299928516;4168.645665118438;4170.9582904170875;4179.2059508693255;5658.943410565924;5664.490195882349;5690.662694266844;5694.572907031948;5714.428557144252;4290.249206388932;4299.570042995675;4303.806328715215;4303.870883873489;4322.200392927319;4243.554426785205;4290.785460726951;4356.49900261474;4375.649948004152;4376.540463251376;4738.31294462308;4782.856514304576;4789.336157839256;4794.904101917942;4816.975915120402;5477.20580515831;5482.396936337;5482.972585137049;5483.669440487777;5503.174523821459;1391.193107997359;1442.9682776814418;1450.4560789703862;1451.7677171652485;1455.5997100797365;1035.5081336365167;1043.801677681238;1059.5602824827765;1062.989370106289;1072.6406653770919;5006.949930500721;5061.417936937226;5068.606133313368;5070.569001634903;5087.542121209109;5373.892522149535;5378.569714422837;5409.647588102975;5425.484578965071;5434.565234781208;4861.222204447342;4943.975280123648;4998.300237966688;5037.19404895215;5091.8981620367385;2817.7745780337523;2839.5802098950526;2842.862854858032;2862.4990626640256;2864.5820318942256;5558.360788509373;5583.637063590853;5627.127795191752;5655.660660360391;5665.3201615806365;5324.494173053554;5489.698066606375;5666.291713535808;5702.230198923092;5742.339630942495;5807.941920580824;5816.5055970243;5832.8541786454825;5863.618864773776;5874.5887787854435;5419.485148910847;5653.378128405954;5659.943400565941;5697.800576979952;5707.143928410772;5544.362398324244;5550.4449555044175;5557.72211389437;5569.637973531708;5579.525740312119;5832.387599302012;5842.883142337215;5844.240248767803;5844.824655260349;5875.794347197828;3956.169204467094;4006.777932730545;4048.5748996356137;4060.3352625423436;4063.5530091689297;5583.8883222336135;5590.7763689453595;5600.159976003632;5603.607747457639;5626.24045753818;5479.452054794648;5498.752556135064;5519.31008623922;5519.972400137974;5521.641093328921;5328.760205790826;5420.349558052902;5470.288862447856;5483.890322193613;5511.917321240265;5461.235427040138;5464.91802622953;5472.507474327171;5472.644278121909;5480.753366098455;5379;5402.189671549299;5504.559635229092;5512;5523.530499907552;5316.494932981361;5339.9466005341;5363.329583802025;5368.248445217595;5382.381026182039 05:19:13 INFO - PROCESS | 12765 | |5;yui.html;737.8302990312225;751.2224847283063;775.457179974018;829.4981536170617;838.9286910612598;14947.626309342259;15725.449609263678;16098.59753506163;16321.183940802943;16399.262033208506;14588;14946.626334341647;15058.849411505882;15217.695646087072;15372.923135384335;758.2796343473681;767.3477544087509;769.0118198115423;769.1769806307253;769.7806125254303;751.0536723728114;768.4812751392816;772.7604442622777;773.5088218980932;774.3843644302793;803.4656953126193;805.4160733468248;806.330745481252;808.8584497712906;814.4054839966798;806.1173015547995;813.6460639621783;814.1248158229897;814.2386868278179;814.3973459639824;591.6479694581717;596.0373995996478;596.4453058655449;596.58537316565;597.2593983460521;16352.918235408866;16370.181490925406;16390.344386224537;16414.425495107615;16894.577635559086;14506;14739.115653060744;14867.479638212611;14983.925080374638;15396.615084622863;11925.224860384047;11935.761284774257;12023.819642705366;12146.757064858743;12559.686007849878;3537.2571759930447;3599.9100022499647;3720.6093360197333;3725.497057897176;3726.962730372689;62041.37958620401;65851.67074164598;80597;82506.17493825045;83301;11217.326960382403;11373.431328433546;11548.133889958286;11639.418029098511;11687.824682629767;21307.147714091574;21587.67618485724;21814.672779908313;21946.122155113935;22032.779672203393;8171.509709417335;8180.427370084037;8269.8346033079;8365.07984121746;8383.090873896319;4203.495580530356;4245.3631955206965;4247.893802654959;4271.23117838792;4348.043430445297;3663.2124093320062;3734.514513113278;3767.6232376762655;3774.7923864187733;3782.867599634;618.3939739055661;621.2482895696259;624.0919462182604;625.2996643759019;635.9872802543923;745.5042396806064;760.8782594784808;766.1534004924589;794.9920500794918;813.2680587471323;10047.346922450017;10158.241450663301;11059.668209953714;11091.39529652866;11197.888021119847;757.9583122928292;763.9809004774814;778.7741554949115;810.7608255564622;810.8580998325269;4597.081930415264;5024.145895197825;5034.924476132861;5046.174142480223;5048.192289233705;79868;81571.5921420389;82289;82493.58753206316;83836;41338.586614134074;44055.559444405786;46047;72124;72267;58428.4157158423;60272.99999999912;60524;60629;61269.387306126366;9105.362624616479;10669.859311660637;11301.886981130083;11305.660830175108;11372.090232781193;37730;39874.60125398825;40246.39630405605;41381.58618413777;41818.58181418147;53673.19490207728;56891.715541422025;58205.84110180988;58799.70600146972;59380.70309648424;11532.769344612892;11586.884131158919;11592.88407115918;11666.88333116658;12305;11769.058475322125;12324.075694322783;14914.925425372803;14928.850711492745;15029.924850375679;14436.783448248494;14938.701225975203;15078.396864125312;15173.696526069638;15450.30473628667;13637.386317615532;13963.650908727363;13996.300184990507;14487.710245795235;14947.850521494645;13531.526396576073;13689.980571745815;13826.170429774245;14485.637859053608;14669.266536673336;11954.222975506564;12085.94227150151;12156.392180390769;12312.445939932904;12771.61685149447;10510.527026283988;10656.520456579317;11187.32876027441;11796.823047654121;12259.448324825582 05:19:13 INFO - PROCESS | 12765 | __end_tp_report 05:19:13 INFO - PROCESS | 12765 | __start_cc_report 05:19:13 INFO - PROCESS | 12765 | _x_x_mozilla_cycle_collect,1232 05:19:13 INFO - PROCESS | 12765 | __end_cc_report 05:19:13 INFO - PROCESS | 12765 | __startTimestamp1486387153906__endTimestamp 05:19:13 INFO - PROCESS | 12765 | 05:19:13 INFO - PROCESS | 12765 | ------- Summary: start ------- 05:19:13 INFO - PROCESS | 12765 | Number of tests: 6 05:19:13 INFO - PROCESS | 12765 | 05:19:13 INFO - PROCESS | 12765 | [#0] dojo.html Cycles:165 Average:5301.27 Median:5519.97 stddev:575.53 (10.4%) stddev-sans-first:552.94 05:19:13 INFO - PROCESS | 12765 | Values: 3189.5 3210.2 3212.8 3230.6 3264.1 5148.3 5193.8 5271.4 5306.0 5329.7 5261.0 5276.1 5287.8 5326.4 5350.3 4768.4 4854.0 4857.9 4871.8 4920.1 4906.5 4923.0 4948.1 4972.4 4976.4 4785.7 4787.4 4808.3 4809.9 4824.7 4830.5 4831.1 4848.9 4917.3 4935.3 4795.9 4818.6 4820.4 4840.2 4868.1 5120.4 5161.6 5170.2 5356.8 5361.4 5604.0 5621.6 5629.7 5631.0 5637.2 5647.9 5660.6 5664.2 5667.9 5671.2 5269.9 5320.1 5381.6 5431.2 5431.8 5857.6 5891.7 5913.8 5918.3 5926.5 5520.0 5543.6 5558.9 5627.0 5630.6 5633.5 5645.5 5652.3 5752.1 5754.3 5699.2 5700.0 5703.0 5708.7 5725.0 5576.4 5622.7 5712.9 5713.7 5718.7 4399.5 4401.1 4423.7 4431.9 4466.7 3958.4 3958.6 3959.4 3974.7 3991.0 5234.1 5339.7 5343.5 5347.6 5348.5 5602.2 5683.1 5702.7 5716.4 5805.2 5373.2 5374.8 5377.2 5379.8 5384.1 4928.0 4940.3 4948.7 4955.4 5002.6 5695.3 5708.7 5751.6 5864.1 5901.8 5666.5 5671.1 5675.7 5701.9 5720.7 5856.1 5904.9 5939.9 5940.9 5941.1 5468.0 5526.3 5594.6 5618.2 5618.9 5791.0 5803.0 5803.7 5829.5 5851.0 5592.5 5600.6 5609.1 5616.0 5668.5 5435.8 5459.5 5463.0 5576.3 5582.7 5613.2 5645.9 5652.2 5660.5 5702.1 5635.6 5658.4 5674.7 5696.6 5699.1 5347.0 5463.6 5475.5 5526.9 5532.4 05:19:13 INFO - PROCESS | 12765 | 05:19:13 INFO - PROCESS | 12765 | [#1] ext.html Cycles:180 Average:52999.70 Median:381480.00 stddev:99203.80 (26.0%) stddev-sans-first:99403.90 05:19:13 INFO - PROCESS | 12765 | Values: 541.6 558.3 569.6 569.8 581.2 31986.5 44713.0 45188.5 45378.5 48725.5 45264.8 45700.3 45741.3 45767.3 45776.9 7686.1 8884.6 9066.6 9069.3 9069.4 7766.9 10756.2 11008.5 11020.4 11358.8 10574.4 10621.7 10636.5 10661.0 10687.9 10582.6 10617.7 10644.8 10651.3 10651.4 10478.3 10515.4 10531.1 10541.1 10543.2 44463.0 44506.3 44803.3 44804.3 44845.0 4059.5 4103.6 4113.7 4132.8 4191.7 28310.7 28687.9 28771.0 28861.6 28973.4 3607.5 3725.1 3731.6 3752.0 3868.7 211707.2 213295.0 213305.9 213724.0 215139.0 58716.3 58766.0 59367.7 59623.4 59677.7 61597.4 61951.0 61997.7 62079.4 62363.0 16017.3 16209.8 16217.0 16224.9 16269.3 12802.8 12862.7 12867.9 12881.4 12917.4 15314.7 16490.8 16517.0 16540.6 16561.8 6162.3 6164.8 6384.6 6394.8 6487.5 909.5 921.6 932.1 932.6 935.3 29063.7 30081.0 30320.4 30399.0 30422.7 1091.7 1114.7 1117.3 1143.3 1220.5 15378.0 15672.2 15848.4 15896.7 16360.5 473737.0 481368.0 481815.0 482635.0 483076.0 61759.4 61889.1 61892.7 62024.0 62158.0 1369.4 1444.6 1448.9 1449.1 1454.9 29012.0 30250.0 30281.2 30812.5 30917.7 38744.2 38804.6 39100.0 39129.0 39134.4 375170.0 380091.0 380663.0 380788.0 382172.0 38490.2 39364.8 39441.4 39910.2 39933.0 44307.0 44897.6 45346.8 45728.5 46022.3 37912.0 38613.8 38950.4 39759.4 40743.8 37754.1 38475.6 39078.0 40042.0 40403.0 35464.0 39970.2 40037.8 40188.0 40323.2 29469.0 31812.4 32198.8 32483.0 32628.7 24406.3 25223.4 25294.7 25586.3 25733.5 05:19:13 INFO - PROCESS | 12765 | 05:19:13 INFO - PROCESS | 12765 | [#2] jquery.html Cycles:180 Average:34321.41 Median:2196.90 stddev:107602.78 (4897.9%) stddev-sans-first:107874.46 05:19:13 INFO - PROCESS | 12765 | Values: 383.4 403.3 423.8 425.7 429.4 13503.6 15065.2 19258.0 20162.6 20483.0 20571.7 20709.5 21057.5 21060.7 21323.0 5704.2 5817.2 5871.9 5923.9 5980.8 3733.7 3917.5 5806.3 5883.6 5907.2 3942.4 3948.8 3960.5 4135.0 6593.1 6647.9 6653.9 6657.9 6677.3 6681.0 5185.3 5413.7 5443.6 5483.5 5487.5 14170.4 14253.1 14254.7 14340.9 14445.3 2510.9 2550.4 2597.0 2601.5 2619.6 9686.0 10425.3 10435.2 10572.0 10813.2 1753.8 1815.5 1838.7 1839.8 1843.4 85397.0 86580.0 86745.0 86939.0 87995.0 11452.7 11541.7 11676.5 11739.0 12371.9 17456.1 17472.1 17487.8 17524.9 17548.6 8142.0 8242.3 8324.5 8393.2 8443.2 7644.7 7648.3 7667.5 7996.4 8004.0 5023.0 5127.7 5139.2 5223.8 5299.6 2099.2 2125.8 2161.0 2161.5 2232.3 985.3 990.3 1004.2 1013.3 1013.8 19928.0 20294.2 20320.7 20551.7 20764.2 975.8 979.1 979.5 994.2 1002.0 10562.4 10649.6 11059.2 11085.9 11670.5 620886.0 632034.0 666214.0 673618.0 675471.0 107784.0 109233.0 110724.4 111724.4 114362.4 1092.2 1112.6 1125.9 1131.8 1142.5 17291.9 17754.7 18416.9 18562.2 18615.5 41038.9 41595.4 45907.0 47356.1 47357.8 57898.0 60265.4 61964.2 62221.2 63979.7 8893.9 8936.0 8939.9 9007.8 9228.7 11612.2 12606.2 13715.7 13732.0 14159.9 11502.3 11523.4 11534.2 11948.9 12290.7 11467.8 11477.6 11803.1 11894.9 12113.5 11363.0 11856.4 11883.8 12078.8 12462.9 8826.7 8886.4 8941.2 9106.0 9331.7 9079.1 10878.7 11557.5 11562.2 11834.8 05:19:13 INFO - PROCESS | 12765 | 05:19:13 INFO - PROCESS | 12765 | [#3] mootools.html Cycles:180 Average:5616.62 Median:5162.96 stddev:3193.42 (61.9%) stddev-sans-first:3186.68 05:19:13 INFO - PROCESS | 12765 | Values: 1403.0 1418.2 1428.4 1430.5 1439.2 8441.2 8838.3 8843.2 8846.8 8864.1 8548.1 8780.9 8837.7 9022.9 9027.4 2275.0 2303.4 2308.2 2308.7 2309.2 1957.2 2027.7 2215.9 2260.5 2260.6 2181.8 2244.1 2253.4 2258.4 2266.6 2190.3 2191.2 2217.2 2217.8 2223.9 2211.6 2217.9 2273.6 2274.7 2276.6 8738.3 8785.2 8794.3 8805.0 8810.9 5068.7 5193.7 5195.1 5198.9 5199.1 3225.8 3266.9 3328.2 3336.0 3363.9 1238.9 1242.1 1272.5 1306.4 1306.6 11871.2 11999.2 12021.7 12075.3 12116.8 4230.0 4431.3 4494.8 4509.2 4609.1 9486.8 9514.8 9517.1 9517.2 9518.2 5162.6 5163.3 5163.7 5167.0 5169.3 4564.3 4610.1 4695.2 4742.2 4818.2 3569.7 3636.5 3702.8 3718.0 3780.3 1012.1 1041.1 1093.1 1094.9 1110.0 783.8 785.6 808.7 816.4 822.8 5531.8 5587.3 5710.8 5738.1 5876.6 996.7 1012.1 1018.7 1034.5 1065.2 3618.2 3708.5 3751.8 3927.8 3929.9 10223.5 10542.8 10614.9 10626.7 10632.4 10293.6 10340.5 10498.3 10583.6 10594.1 7951.8 8116.4 8127.3 8130.3 8134.2 5422.7 5483.2 5609.7 5650.6 5797.9 9500.2 9520.3 9544.4 9556.8 9642.9 9393.3 9560.5 9677.7 9707.6 9738.0 7264.1 7508.0 7565.3 7583.6 7751.9 8259.2 8336.8 8378.5 8403.1 8419.7 7406.5 7462.1 7478.0 7484.4 7578.0 7213.7 7408.3 7475.6 7484.0 7491.4 6398.7 6609.5 6623.8 6654.8 6661.7 5000.2 5135.9 5178.2 5181.2 5402.0 5093.6 5095.1 5133.7 5215.6 5416.0 05:19:13 INFO - PROCESS | 12765 | 05:19:13 INFO - PROCESS | 12765 | [#4] prototype.html Cycles:180 Average:4643.11 Median:5095.78 stddev:1313.78 (25.8%) stddev-sans-first:1277.65 05:19:13 INFO - PROCESS | 12765 | Values: 366.5 381.1 382.4 392.7 400.8 5049.8 5190.2 5279.7 5290.1 5295.2 5062.3 5141.6 5147.6 5174.2 5207.7 4198.3 4207.5 4215.3 4225.2 4238.5 3939.7 4017.9 4199.7 4220.7 4228.7 4177.4 4203.6 4209.7 4212.3 4222.5 4166.0 4194.2 4200.5 4202.9 4214.1 3822.3 3835.3 3838.3 3839.3 3845.4 4887.9 4993.9 5035.9 5081.5 5099.7 4821.2 4845.5 4848.1 4852.8 4859.0 5337.7 5511.6 5511.9 5515.7 5520.5 4112.2 4159.4 4168.6 4171.0 4179.2 5658.9 5664.5 5690.7 5694.6 5714.4 4290.2 4299.6 4303.8 4303.9 4322.2 4243.6 4290.8 4356.5 4375.6 4376.5 4738.3 4782.9 4789.3 4794.9 4817.0 5477.2 5482.4 5483.0 5483.7 5503.2 1391.2 1443.0 1450.5 1451.8 1455.6 1035.5 1043.8 1059.6 1063.0 1072.6 5006.9 5061.4 5068.6 5070.6 5087.5 5373.9 5378.6 5409.6 5425.5 5434.6 4861.2 4944.0 4998.3 5037.2 5091.9 2817.8 2839.6 2842.9 2862.5 2864.6 5558.4 5583.6 5627.1 5655.7 5665.3 5324.5 5489.7 5666.3 5702.2 5742.3 5807.9 5816.5 5832.9 5863.6 5874.6 5419.5 5653.4 5659.9 5697.8 5707.1 5544.4 5550.4 5557.7 5569.6 5579.5 5832.4 5842.9 5844.2 5844.8 5875.8 3956.2 4006.8 4048.6 4060.3 4063.6 5583.9 5590.8 5600.2 5603.6 5626.2 5479.5 5498.8 5519.3 5520.0 5521.6 5328.8 5420.3 5470.3 5483.9 5511.9 5461.2 5464.9 5472.5 5472.6 5480.8 5379.0 5402.2 5504.6 5512.0 5523.5 5316.5 5339.9 5363.3 5368.2 5382.4 05:19:13 INFO - PROCESS | 12765 | 05:19:13 INFO - PROCESS | 12765 | [#5] yui.html Cycles:180 Average:17303.89 Median:40060.50 stddev:21630.59 (54.0%) stddev-sans-first:21655.50 05:19:13 INFO - PROCESS | 12765 | Values: 737.8 751.2 775.5 829.5 838.9 14947.6 15725.4 16098.6 16321.2 16399.3 14588.0 14946.6 15058.8 15217.7 15372.9 758.3 767.3 769.0 769.2 769.8 751.1 768.5 772.8 773.5 774.4 803.5 805.4 806.3 808.9 814.4 806.1 813.6 814.1 814.2 814.4 591.6 596.0 596.4 596.6 597.3 16352.9 16370.2 16390.3 16414.4 16894.6 14506.0 14739.1 14867.5 14983.9 15396.6 11925.2 11935.8 12023.8 12146.8 12559.7 3537.3 3599.9 3720.6 3725.5 3727.0 62041.4 65851.7 80597.0 82506.2 83301.0 11217.3 11373.4 11548.1 11639.4 11687.8 21307.1 21587.7 21814.7 21946.1 22032.8 8171.5 8180.4 8269.8 8365.1 8383.1 4203.5 4245.4 4247.9 4271.2 4348.0 3663.2 3734.5 3767.6 3774.8 3782.9 618.4 621.2 624.1 625.3 636.0 745.5 760.9 766.2 795.0 813.3 10047.3 10158.2 11059.7 11091.4 11197.9 758.0 764.0 778.8 810.8 810.9 4597.1 5024.1 5034.9 5046.2 5048.2 79868.0 81571.6 82289.0 82493.6 83836.0 41338.6 44055.6 46047.0 72124.0 72267.0 58428.4 60273.0 60524.0 60629.0 61269.4 9105.4 10669.9 11301.9 11305.7 11372.1 37730.0 39874.6 40246.4 41381.6 41818.6 53673.2 56891.7 58205.8 58799.7 59380.7 11532.8 11586.9 11592.9 11666.9 12305.0 11769.1 12324.1 14914.9 14928.9 15029.9 14436.8 14938.7 15078.4 15173.7 15450.3 13637.4 13963.7 13996.3 14487.7 14947.9 13531.5 13690.0 13826.2 14485.6 14669.3 11954.2 12085.9 12156.4 12312.4 12771.6 10510.5 10656.5 11187.3 11796.8 12259.4 05:19:13 INFO - PROCESS | 12765 | -------- Summary: end -------- 05:19:13 INFO - PROCESS | 12765 | 05:19:14 INFO - TEST-INFO | 12765: exit 0 05:19:14 INFO - TEST-OK | dromaeo_css | took 1116486ms 05:19:14 INFO - TEST-START | kraken 05:19:14 INFO - operating with platform_type : linux_ 05:19:14 INFO - Initialising browser for kraken test... 05:19:14 INFO - TEST-INFO | started process 13074 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAjdoy8/profile http://localhost:51859/getInfo.html) 05:19:18 INFO - PROCESS | 13074 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 05:19:18 INFO - PROCESS | 13074 | __metrics Screen width/height:1600/1200 05:19:18 INFO - PROCESS | 13074 | colorDepth:24 05:19:18 INFO - PROCESS | 13074 | Browser inner width/height: 1024/697 05:19:18 INFO - PROCESS | 13074 | __metrics 05:19:19 INFO - PROCESS | 13074 | 1486387159673 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 05:19:19 INFO - PROCESS | 13074 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:19:19 INFO - PROCESS | 13074 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:19:20 INFO - TEST-INFO | 13074: exit 0 05:19:20 INFO - Browser initialized. 05:19:20 INFO - Running cycle 1/1 for kraken test... 05:19:20 INFO - TEST-INFO | started process 13159 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAjdoy8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:19:32 INFO - PROCESS | 13159 | RSS: Main: 148631552 05:19:32 INFO - PROCESS | 13159 | 05:19:35 INFO - PROCESS | 13159 | Cycle 1(1): loaded http://localhost:51859/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51859/tests/kraken/driver.html?testName=audio-beat-detection) 05:19:36 INFO - PROCESS | 13159 | RSS: Main: 204001280 05:19:36 INFO - PROCESS | 13159 | 05:19:38 INFO - PROCESS | 13159 | Cycle 1(1): loaded http://localhost:51859/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51859/tests/kraken/driver.html?testName=audio-dft) 05:19:39 INFO - PROCESS | 13159 | RSS: Main: 183066624 05:19:39 INFO - PROCESS | 13159 | 05:19:42 INFO - PROCESS | 13159 | Cycle 1(1): loaded http://localhost:51859/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51859/tests/kraken/driver.html?testName=audio-fft) 05:19:42 INFO - PROCESS | 13159 | RSS: Main: 264429568 05:19:42 INFO - PROCESS | 13159 | 05:19:45 INFO - PROCESS | 13159 | Cycle 1(1): loaded http://localhost:51859/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51859/tests/kraken/driver.html?testName=audio-oscillator) 05:19:45 INFO - PROCESS | 13159 | RSS: Main: 175104000 05:19:45 INFO - PROCESS | 13159 | 05:19:47 INFO - PROCESS | 13159 | Cycle 1(1): loaded http://localhost:51859/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51859/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:19:48 INFO - PROCESS | 13159 | RSS: Main: 180002816 05:19:48 INFO - PROCESS | 13159 | 05:19:51 INFO - PROCESS | 13159 | Cycle 1(1): loaded http://localhost:51859/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51859/tests/kraken/driver.html?testName=imaging-darkroom) 05:19:52 INFO - PROCESS | 13159 | RSS: Main: 219914240 05:19:52 INFO - PROCESS | 13159 | 05:19:55 INFO - PROCESS | 13159 | Cycle 1(1): loaded http://localhost:51859/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51859/tests/kraken/driver.html?testName=imaging-desaturate) 05:19:56 INFO - PROCESS | 13159 | RSS: Main: 218972160 05:19:56 INFO - PROCESS | 13159 | 05:19:58 INFO - PROCESS | 13159 | Cycle 1(1): loaded http://localhost:51859/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51859/tests/kraken/driver.html?testName=json-parse-financial) 05:19:59 INFO - PROCESS | 13159 | RSS: Main: 218062848 05:19:59 INFO - PROCESS | 13159 | 05:20:00 INFO - PROCESS | 13159 | Cycle 1(1): loaded http://localhost:51859/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51859/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:20:01 INFO - PROCESS | 13159 | RSS: Main: 180711424 05:20:01 INFO - PROCESS | 13159 | 05:20:03 INFO - PROCESS | 13159 | Cycle 1(1): loaded http://localhost:51859/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51859/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:20:03 INFO - PROCESS | 13159 | RSS: Main: 187973632 05:20:03 INFO - PROCESS | 13159 | 05:20:06 INFO - PROCESS | 13159 | Cycle 1(1): loaded http://localhost:51859/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51859/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:20:06 INFO - PROCESS | 13159 | RSS: Main: 196808704 05:20:06 INFO - PROCESS | 13159 | 05:20:09 INFO - PROCESS | 13159 | Cycle 1(1): loaded http://localhost:51859/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51859/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:20:09 INFO - PROCESS | 13159 | RSS: Main: 205565952 05:20:09 INFO - PROCESS | 13159 | 05:20:12 INFO - PROCESS | 13159 | Cycle 1(1): loaded http://localhost:51859/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51859/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:20:13 INFO - PROCESS | 13159 | RSS: Main: 202174464 05:20:13 INFO - PROCESS | 13159 | 05:20:15 INFO - PROCESS | 13159 | Cycle 1(1): loaded http://localhost:51859/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51859/tests/kraken/driver.html?testName=ai-astar) 05:20:15 INFO - PROCESS | 13159 | RSS: Main: 255086592 05:20:15 INFO - PROCESS | 13159 | 05:20:15 INFO - PROCESS | 13159 | __start_tp_report 05:20:15 INFO - PROCESS | 13159 | _x_x_mozilla_page_load 05:20:15 INFO - PROCESS | 13159 | _x_x_mozilla_page_load_details 05:20:15 INFO - PROCESS | 13159 | |i|pagename|runs| 05:20:15 INFO - PROCESS | 13159 | |0;ai-astar;109;111;112;112;112;112;112;114;113;113 05:20:15 INFO - PROCESS | 13159 | |1;audio-beat-detection;144;119;118;169;120;120;118;118;147;119 05:20:15 INFO - PROCESS | 13159 | |2;audio-dft;161;160;160;160;160;160;161;161;161;161 05:20:15 INFO - PROCESS | 13159 | |3;audio-fft;75;76;76;106;78;76;75;74;99;76 05:20:15 INFO - PROCESS | 13159 | |4;audio-oscillator;83;83;116;83;83;83;106;83;83;114 05:20:15 INFO - PROCESS | 13159 | |5;imaging-gaussian-blur;117;117;116;117;117;117;116;117;117;117 05:20:15 INFO - PROCESS | 13159 | |6;imaging-darkroom;146;147;147;146;146;146;147;146;147;146 05:20:15 INFO - PROCESS | 13159 | |7;imaging-desaturate;95;96;96;96;96;97;97;95;96;96 05:20:15 INFO - PROCESS | 13159 | |8;json-parse-financial;53;53;53;55;55;55;54;55;54;55 05:20:15 INFO - PROCESS | 13159 | |9;json-stringify-tinderbox;63;63;63;63;63;62;63;67;63;63 05:20:15 INFO - PROCESS | 13159 | |10;stanford-crypto-aes;83;82;83;82;82;82;84;82;81;82 05:20:15 INFO - PROCESS | 13159 | |11;stanford-crypto-ccm;129;130;126;126;139;127;125;132;170;142 05:20:15 INFO - PROCESS | 13159 | |12;stanford-crypto-pbkdf2;173;168;168;167;168;169;166;174;166;168 05:20:15 INFO - PROCESS | 13159 | |13;stanford-crypto-sha256-iterative;70;65;63;62;62;62;63;61;62;61 05:20:15 INFO - PROCESS | 13159 | __end_tp_report 05:20:15 INFO - PROCESS | 13159 | __start_cc_report 05:20:15 INFO - PROCESS | 13159 | _x_x_mozilla_cycle_collect,1731 05:20:15 INFO - PROCESS | 13159 | __end_cc_report 05:20:15 INFO - PROCESS | 13159 | __startTimestamp1486387215283__endTimestamp 05:20:15 INFO - PROCESS | 13159 | 05:20:15 INFO - PROCESS | 13159 | ------- Summary: start ------- 05:20:15 INFO - PROCESS | 13159 | Number of tests: 14 05:20:15 INFO - PROCESS | 13159 | 05:20:15 INFO - PROCESS | 13159 | [#0] ai-astar Cycles:10 Average:112.00 Median:112.00 stddev:1.33 (1.2%) stddev-sans-first:0.87 05:20:15 INFO - PROCESS | 13159 | Values: 109.0 111.0 112.0 112.0 112.0 112.0 112.0 114.0 113.0 113.0 05:20:15 INFO - PROCESS | 13159 | 05:20:15 INFO - PROCESS | 13159 | [#1] audio-beat-detection Cycles:10 Average:129.20 Median:120.00 stddev:17.87 (14.9%) stddev-sans-first:18.13 05:20:15 INFO - PROCESS | 13159 | Values: 144.0 119.0 118.0 169.0 120.0 120.0 118.0 118.0 147.0 119.0 05:20:15 INFO - PROCESS | 13159 | 05:20:15 INFO - PROCESS | 13159 | [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:0.53 (0.3%) stddev-sans-first:0.53 05:20:15 INFO - PROCESS | 13159 | Values: 161.0 160.0 160.0 160.0 160.0 160.0 161.0 161.0 161.0 161.0 05:20:15 INFO - PROCESS | 13159 | 05:20:15 INFO - PROCESS | 13159 | [#3] audio-fft Cycles:10 Average:81.10 Median:76.00 stddev:11.45 (15.1%) stddev-sans-first:11.92 05:20:15 INFO - PROCESS | 13159 | Values: 75.0 76.0 76.0 106.0 78.0 76.0 75.0 74.0 99.0 76.0 05:20:15 INFO - PROCESS | 13159 | 05:20:15 INFO - PROCESS | 13159 | [#4] audio-oscillator Cycles:10 Average:91.70 Median:83.00 stddev:14.23 (17.1%) stddev-sans-first:14.74 05:20:15 INFO - PROCESS | 13159 | Values: 83.0 83.0 116.0 83.0 83.0 83.0 106.0 83.0 83.0 114.0 05:20:15 INFO - PROCESS | 13159 | 05:20:15 INFO - PROCESS | 13159 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:20:15 INFO - PROCESS | 13159 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 05:20:15 INFO - PROCESS | 13159 | 05:20:15 INFO - PROCESS | 13159 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 05:20:15 INFO - PROCESS | 13159 | Values: 146.0 147.0 147.0 146.0 146.0 146.0 147.0 146.0 147.0 146.0 05:20:15 INFO - PROCESS | 13159 | 05:20:15 INFO - PROCESS | 13159 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.60 05:20:15 INFO - PROCESS | 13159 | Values: 95.0 96.0 96.0 96.0 96.0 97.0 97.0 95.0 96.0 96.0 05:20:15 INFO - PROCESS | 13159 | 05:20:15 INFO - PROCESS | 13159 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:55.00 stddev:0.92 (1.7%) stddev-sans-first:0.87 05:20:15 INFO - PROCESS | 13159 | Values: 53.0 53.0 53.0 55.0 55.0 55.0 54.0 55.0 54.0 55.0 05:20:15 INFO - PROCESS | 13159 | 05:20:15 INFO - PROCESS | 13159 | [#9] json-stringify-tinderbox Cycles:10 Average:63.30 Median:63.00 stddev:1.34 (2.1%) stddev-sans-first:1.41 05:20:15 INFO - PROCESS | 13159 | Values: 63.0 63.0 63.0 63.0 63.0 62.0 63.0 67.0 63.0 63.0 05:20:15 INFO - PROCESS | 13159 | 05:20:15 INFO - PROCESS | 13159 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:82.00 stddev:0.82 (1.0%) stddev-sans-first:0.83 05:20:15 INFO - PROCESS | 13159 | Values: 83.0 82.0 83.0 82.0 82.0 82.0 84.0 82.0 81.0 82.0 05:20:15 INFO - PROCESS | 13159 | 05:20:15 INFO - PROCESS | 13159 | [#11] stanford-crypto-ccm Cycles:10 Average:134.60 Median:131.00 stddev:13.68 (10.4%) stddev-sans-first:14.36 05:20:15 INFO - PROCESS | 13159 | Values: 129.0 130.0 126.0 126.0 139.0 127.0 125.0 132.0 170.0 142.0 05:20:15 INFO - PROCESS | 13159 | 05:20:15 INFO - PROCESS | 13159 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.70 Median:168.00 stddev:2.71 (1.6%) stddev-sans-first:2.39 05:20:15 INFO - PROCESS | 13159 | Values: 173.0 168.0 168.0 167.0 168.0 169.0 166.0 174.0 166.0 168.0 05:20:15 INFO - PROCESS | 13159 | 05:20:15 INFO - PROCESS | 13159 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.10 Median:62.50 stddev:2.69 (4.3%) stddev-sans-first:1.22 05:20:15 INFO - PROCESS | 13159 | Values: 70.0 65.0 63.0 62.0 62.0 62.0 63.0 61.0 62.0 61.0 05:20:15 INFO - PROCESS | 13159 | -------- Summary: end -------- 05:20:15 INFO - PROCESS | 13159 | 05:20:16 INFO - TEST-INFO | 13159: exit 0 05:20:16 INFO - TEST-OK | kraken | took 61627ms 05:20:16 INFO - SUITE-END | took 1178s 05:20:16 INFO - Completed test suite (00:19:38) 05:20:16 INFO - javascript benchmark 05:20:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7158.1082416856925, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3189.5375170600264, 3210.2134976930647, 3212.8232947187894, 3230.644629090801, 3264.118687954251, 5148.330717006784, 5193.792248310073, 5271.367435907687, 5306.0, 5329.680219186846, 5260.973695131529, 5276.050310944029, 5287.762050707718, 5326.360836699601, 5350.27771250882, 4768.403949506303, 4853.951460485403, 4857.927131093036, 4871.780769865347, 4920.065187614342, 4906.484819093997, 4923.040007198598, 4948.1093403187415, 4972.43087741728, 4976.3530741003615, 4785.736784476852, 4787.377640906678, 4808.3027960945465, 4809.855704328858, 4824.662273640846, 4830.516948305177, 4831.106245344622, 4848.903021939576, 4917.286993385939, 4935.3090567320605, 4795.928061079052, 4818.59041981432, 4820.373351464323, 4840.201366774478, 4868.123737727207, 5120.436751957319, 5161.561267292284, 5170.224466330043, 5356.758945847446, 5361.383440904307, 5604.0, 5621.606487545873, 5629.662220266797, 5630.971845140789, 5637.210790489335, 5647.887042259173, 5660.632058916199, 5664.235328230719, 5667.886642267132, 5671.234383358235, 5269.947300527022, 5320.14877619579, 5381.623286369995, 5431.2396264522995, 5431.8098866539485, 5857.619254748428, 5891.734871930774, 5913.822585322448, 5918.2898052234, 5926.525877929756, 5519.972400137974, 5543.6396634218645, 5558.944410555923, 5627.043402621564, 5630.6058575900115, 5633.549316054706, 5645.5483561314995, 5652.265205523256, 5752.050911599539, 5754.251947246831, 5699.202111704365, 5700.030994730822, 5702.971485142548, 5708.65748055118, 5725.0, 5576.358718747396, 5622.690752008597, 5712.914306285409, 5713.714314284269, 5718.714064296769, 4399.450068741407, 4401.053773438726, 4423.6903416760515, 4431.889202769957, 4466.731996080245, 3958.426028225891, 3958.5645578986287, 3959.4456776051375, 3974.6621537169663, 3991.0, 5234.110201265794, 5339.733013349317, 5343.492368225013, 5347.598930080259, 5348.491893270133, 5602.187682785973, 5683.062294721325, 5702.686352250583, 5716.42835716425, 5805.216295800013, 5373.167159090347, 5374.811881584125, 5377.247185394048, 5379.811706590251, 5384.138537833927, 4928.0, 4940.283658869444, 4948.703077815343, 4955.40535135786, 5002.57478114357, 5695.288088988877, 5708.743106560131, 5751.59738818287, 5864.120381942743, 5901.793437229677, 5666.46168613981, 5671.092625180117, 5675.7445914933105, 5701.888131814422, 5720.656760594377, 5856.0630299151935, 5904.911426328523, 5939.910901336397, 5940.940590594038, 5941.1088336749835, 5467.972660136674, 5526.336839579276, 5594.580406469449, 5618.213450116905, 5618.887622247614, 5790.9710451449155, 5803.042497987784, 5803.680797556175, 5829.47534721877, 5851.0, 5592.468715472024, 5600.60795744294, 5609.1305847593685, 5616.0452723038, 5668.51817595509, 5435.83692489226, 5459.535939445192, 5463.0, 5576.302962129734, 5582.748776305158, 5613.158026296088, 5645.887082258249, 5652.236948012131, 5660.518855897295, 5702.144678298288, 5635.633683810704, 5658.377578466448, 5674.74463649145, 5696.572757043155, 5699.145128230799, 5347.0375332440535, 5463.617546771847, 5475.479829416199, 5526.861828454321, 5532.446755324436], "value": 5264.822377858244, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [541.5505130741484, 558.3272157050754, 569.5529009727364, 569.82050654044, 581.226968132384, 31986.520202196956, 44713.0, 45188.54811451889, 45378.54621453785, 48725.51274487254, 45264.773676131575, 45700.3144952826, 45741.313880291826, 45767.313490297674, 45776.85557861055, 7686.116096648873, 8884.600192991298, 9066.592003359832, 9069.319801014917, 9069.410488318272, 7766.883496747553, 10756.19328550362, 11008.504617292201, 11020.393878336688, 11358.772824543505, 10574.365538067741, 10621.681349559525, 10636.46817659114, 10661.0, 10687.946560267188, 10582.576696932114, 10617.73455663607, 10644.840327395095, 10651.25441219115, 10651.360918344886, 10478.318909270873, 10515.369077855354, 10531.104856087242, 10541.104006159485, 10543.156547476183, 44463.0, 44506.33240501395, 44803.32795008078, 44804.327935081, 44845.0, 4059.4519739835337, 4103.589641035903, 4113.732607380511, 4132.793360331972, 4191.72753771007, 28310.71689283122, 28687.85656071727, 28771.0, 28861.56707649387, 28973.42053158946, 3607.4769158472136, 3725.0873535983587, 3731.6454936781233, 3751.962480375216, 3868.7485313454536, 211707.18049736525, 213295.0, 213305.9334703332, 213724.0, 215139.0, 58716.31180855111, 58766.0, 59367.703161483914, 59623.403765962656, 59677.701611492535, 61597.38402615916, 61951.0, 61997.690011549654, 62079.379206208265, 62363.0, 16017.279222435018, 16209.83790162107, 16217.0, 16224.918875405547, 16269.267882945296, 12802.80795788064, 12862.678433039062, 12867.871321286855, 12881.420336084899, 12917.418716157796, 15314.693706126038, 16490.75263871043, 16517.0, 16540.586485337964, 16561.83438165627, 6162.291336496271, 6164.753409863555, 6384.648844313608, 6394.840128996812, 6487.481001519962, 909.486140330711, 921.6129225725211, 932.0958670090001, 932.6316105138433, 935.3452583191793, 29063.709362906102, 30081.0, 30320.393592128035, 30399.0, 30422.69577304243, 1091.6888686724403, 1114.7324642085841, 1117.3016864459712, 1143.331151276496, 1220.4751956658545, 15378.0, 15672.216389180723, 15848.366065357488, 15896.682066358608, 16360.482496263123, 473737.0, 481368.0, 481815.0, 482635.0, 483076.0, 61759.382406176264, 61889.071663925075, 61892.69053654703, 62024.0, 62158.0, 1369.3906211735682, 1444.6243976566168, 1448.9058211216447, 1449.0508716790519, 1454.941802327916, 29012.0, 30250.0, 30281.24296892595, 30812.53781193239, 30917.69082309148, 38744.2251154981, 38804.6119538801, 39100.0, 39129.0, 39134.412983804694, 375170.0, 380091.0, 380663.0, 380788.0, 382172.0, 38490.23019539649, 39364.803175983936, 39441.40837887376, 39910.2017959645, 39933.0, 44307.0, 44897.55102448934, 45346.77326613346, 45728.54271457243, 46022.309665354376, 37912.0, 38613.80693096516, 38950.40494860005, 39759.40360894531, 40743.7962810184, 37754.149972806765, 38475.615243848326, 39078.0, 40042.0, 40403.0, 35464.0, 39970.200595987335, 40037.79981100076, 40188.0, 40323.1935361297, 29469.0, 31812.36375272435, 32198.83900580482, 32483.0, 32628.673713262564, 24406.26781196567, 25223.36941576475, 25294.747052529237, 25586.336888102214, 25733.485330292915], "value": 19597.107355906664, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.3674437178657, 403.33248473775893, 423.8347044652585, 425.73391630231106, 429.39240974021743, 13503.594892153227, 15065.171415572138, 19257.99999999998, 20162.59674806503, 20483.0, 20571.691424628643, 20709.482262943435, 21057.47356316093, 21060.684089738665, 21323.0, 5704.172894930232, 5817.214676018747, 5871.9412805871825, 5923.940760592403, 5980.79067232647, 3733.7199710021723, 3917.4515567820386, 5806.332271788735, 5883.617564858292, 5907.232059832238, 3942.4086387041884, 3948.7828169450668, 3960.544537378195, 4135.04893874409, 6593.076969224312, 6647.900281495781, 6653.866922661544, 6657.9334206657795, 6677.298883617247, 6680.966595167018, 5185.274061631375, 5413.729313534347, 5443.564514838803, 5483.451654834525, 5487.533559647395, 14170.433182672681, 14253.073550219202, 14254.714905701829, 14340.856591434056, 14445.277736113258, 2510.924672259835, 2550.4006558458746, 2596.9870150649126, 2601.5447296722996, 2619.620155077503, 9686.0, 10425.322354046963, 10435.234143686674, 10572.0, 10813.18901082422, 1753.8070812210647, 1815.48258746258, 1838.6598479281377, 1839.760831091963, 1843.4184510329671, 85397.0, 86580.03930989321, 86745.0, 86939.0, 87995.0, 11452.682941461671, 11541.711457213469, 11676.532938682527, 11739.0, 12371.938140309421, 17456.127193640266, 17472.126393680264, 17487.825121748872, 17524.91237543804, 17548.64902701939, 8141.959290203511, 8242.2581967622, 8324.500529968222, 8393.24460798531, 8443.155684431507, 7644.655990480442, 7648.34989025939, 7667.463277570628, 7996.400269979775, 8003.9599802001785, 5023.02051100032, 5127.66670166438, 5139.177731562932, 5223.843284701465, 5299.6025298102795, 2099.2337796704396, 2125.776793436698, 2160.967585486219, 2161.4812445013085, 2232.319142661504, 985.3447457440865, 990.2968892086556, 1004.1866088468364, 1013.2653825976108, 1013.8073765984586, 19928.0, 20294.18823247083, 20320.69518957217, 20551.691724624143, 20764.169433222803, 975.8048390321964, 979.1041197304529, 979.5249304087512, 994.1847684898459, 1001.9949900250452, 10562.419066951237, 10649.574017039387, 11059.22585419013, 11085.889141108648, 11670.533178672928, 620886.0, 632034.0, 666214.0, 673618.0, 675471.0, 107784.0, 109233.0, 110724.4463777676, 111724.4413777926, 114362.42818785853, 1092.224520590374, 1112.6495154026618, 1125.876153623101, 1131.7623299107115, 1142.4915912418894, 17291.9249690038, 17754.733678995082, 18416.90791546034, 18562.164702588685, 18615.53461163482, 41038.9273916703, 41595.376069358375, 45907.0, 47356.05287894154, 47357.76321118372, 57898.0, 60265.39734602598, 61964.18393976569, 62221.20004599713, 63979.68010160106, 8893.911060889308, 8935.955320223356, 8939.910600894167, 9007.774805629911, 9228.676996305365, 11612.21306886358, 12606.180598261084, 13715.725685486434, 13732.0, 14159.929200353932, 11502.309861408343, 11523.423828808694, 11534.1926065178, 11948.940255298668, 12290.692732681755, 11467.770644587228, 11477.5897061618, 11803.114766392726, 11894.940525297665, 12113.515459381526, 11363.0, 11856.407179641155, 11883.821742673694, 12078.758424831278, 12462.875371246171, 8826.691065812665, 8886.37795354319, 8941.195292423714, 9105.954470227607, 9331.673391431268, 9079.137481939206, 10878.74863006862, 11557.479913404086, 11562.190646654653, 11834.76330473403], "value": 9414.992364018668, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1402.9508967186143, 1418.1774570748967, 1428.378655284951, 1430.5207755401946, 1439.1724758263997, 8441.240288374052, 8838.292936565076, 8843.159899809507, 8846.823063538724, 8864.113588641148, 8548.14518548145, 8780.868286975701, 8837.734867953972, 9022.86465703015, 9027.413218140833, 2275.0444813178424, 2303.366574192094, 2308.203669733939, 2308.68832707584, 2309.157157637467, 1957.2171131547352, 2027.7262569553143, 2215.8892055397246, 2260.5026894083358, 2260.6156953317977, 2181.770914054025, 2244.147224054857, 2253.4141123307977, 2258.390234636647, 2266.648669456237, 2190.3319487556287, 2191.244020812817, 2217.1796435318956, 2217.84475086744, 2223.9332820015425, 2211.6129677306567, 2217.9112835486562, 2273.579387813243, 2274.749777524471, 2276.5674521840797, 8738.30093592511, 8785.165409286172, 8794.252488538483, 8804.955975220148, 8810.911890881072, 5068.670536415121, 5193.68837869729, 5195.064888320101, 5198.870028249286, 5199.090159222121, 3225.8387080646107, 3266.8529916153593, 3328.21786880083, 3335.983320083408, 3363.882264120744, 1238.907081968847, 1242.0994778785398, 1272.5100836178046, 1306.3990564340415, 1306.5818937939864, 11871.169018168732, 11999.220050696764, 12021.699457513545, 12075.335856527887, 12116.757664846742, 4229.97885010573, 4431.313146462304, 4494.797734101973, 4509.188346097734, 4609.147307748078, 9486.762830929281, 9514.809703805886, 9517.143457088896, 9517.191038761783, 9518.190953768868, 5162.6386152968935, 5163.277141200235, 5163.741812909339, 5166.974165129151, 5169.25045868347, 4564.269716845289, 4610.05493873755, 4695.154872122982, 4742.170120228946, 4818.156822556039, 3569.714422846166, 3636.5454318210222, 3702.777833330009, 3718.0, 3780.281746468162, 1012.089119792193, 1041.094248004241, 1093.1307464236245, 1094.8631421072366, 1109.9611513596985, 783.804048987753, 785.6229010075195, 808.7331180710469, 816.3877092180865, 822.7943014246439, 5531.778728850882, 5587.273654424899, 5710.828675139753, 5738.139279108083, 5876.6180198286975, 996.7009897030862, 1012.1447376966452, 1018.7045756730613, 1034.5189486888632, 1065.1532032034552, 3618.16782140104, 3708.49935258742, 3751.793651349202, 3927.8036098194975, 3929.8821035368983, 10223.488825558692, 10542.841857372145, 10614.89385106139, 10626.73433164177, 10632.415217162976, 10293.639722609672, 10340.482975851177, 10498.265121441425, 10583.57665693379, 10594.099501542301, 7951.801204969922, 8116.431849770577, 8127.268545830903, 8130.268275855083, 8134.186581341818, 5422.674639521641, 5483.2323474712775, 5609.691466969192, 5650.63270887391, 5797.8550536236935, 9500.239980801382, 9520.285978551497, 9544.42733435996, 9556.808863822545, 9642.855357169788, 9393.295502837178, 9560.521973901416, 9677.661281855102, 9707.611695532381, 9737.951310243687, 7264.091988501437, 7507.962460187664, 7565.2812982766545, 7583.582902940391, 7751.8837217442915, 8259.21537453941, 8336.791580210544, 8378.455400398954, 8403.117672644285, 8419.663213471638, 7406.518576292524, 7462.141853686679, 7478.0, 7484.401247900264, 7577.962110189414, 7213.6753846076, 7408.296211859864, 7475.551466912003, 7484.0, 7491.3632341251605, 6398.680065996775, 6609.537332386687, 6623.834404139935, 6654.800355989328, 6661.666916654245, 5000.224965130411, 5135.92296115566, 5178.223266509903, 5181.248718935809, 5402.000629883484, 5093.6179786516905, 5095.133827249302, 5133.6919784813035, 5215.608829337739, 5416.0], "value": 4482.156789760752, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.52168919559966, 381.13862670364966, 382.3996325768543, 392.66034879828936, 400.8096154326695, 5049.798008079672, 5190.221466779984, 5279.683219006863, 5290.095565596387, 5295.232191332255, 5062.341895553573, 5141.562967147797, 5147.613928955325, 5174.172132458807, 5207.6875387476775, 4198.286291330481, 4207.516135644394, 4215.3255479123345, 4225.19721252961, 4238.516519218279, 3939.704522160835, 4017.8794636160815, 4199.664026877857, 4220.746755194683, 4228.743867222237, 4177.436046133778, 4203.558626344236, 4209.705320627558, 4212.304969680014, 4222.472190976128, 4166.0, 4194.2450358935375, 4200.495940487131, 4202.873913782576, 4214.1247145020325, 3822.3310920588788, 3835.3096442640312, 3838.2707285615643, 3839.2897313996723, 3845.3849383258816, 4887.877803054952, 4993.925091123636, 5035.92446113305, 5081.5263573563625, 5099.6685215460875, 4821.204501257288, 4845.53967373099, 4848.054629347279, 4852.805887764485, 4859.0, 5337.704786941614, 5511.58663100269, 5511.917321240185, 5515.669059856381, 5520.530754885839, 4112.177564487085, 4159.355299928516, 4168.645665118438, 4170.9582904170875, 4179.2059508693255, 5658.943410565924, 5664.490195882349, 5690.662694266844, 5694.572907031948, 5714.428557144252, 4290.249206388932, 4299.570042995675, 4303.806328715215, 4303.870883873489, 4322.200392927319, 4243.554426785205, 4290.785460726951, 4356.49900261474, 4375.649948004152, 4376.540463251376, 4738.31294462308, 4782.856514304576, 4789.336157839256, 4794.904101917942, 4816.975915120402, 5477.20580515831, 5482.396936337, 5482.972585137049, 5483.669440487777, 5503.174523821459, 1391.193107997359, 1442.9682776814418, 1450.4560789703862, 1451.7677171652485, 1455.5997100797365, 1035.5081336365167, 1043.801677681238, 1059.5602824827765, 1062.989370106289, 1072.6406653770919, 5006.949930500721, 5061.417936937226, 5068.606133313368, 5070.569001634903, 5087.542121209109, 5373.892522149535, 5378.569714422837, 5409.647588102975, 5425.484578965071, 5434.565234781208, 4861.222204447342, 4943.975280123648, 4998.300237966688, 5037.19404895215, 5091.8981620367385, 2817.7745780337523, 2839.5802098950526, 2842.862854858032, 2862.4990626640256, 2864.5820318942256, 5558.360788509373, 5583.637063590853, 5627.127795191752, 5655.660660360391, 5665.3201615806365, 5324.494173053554, 5489.698066606375, 5666.291713535808, 5702.230198923092, 5742.339630942495, 5807.941920580824, 5816.5055970243, 5832.8541786454825, 5863.618864773776, 5874.5887787854435, 5419.485148910847, 5653.378128405954, 5659.943400565941, 5697.800576979952, 5707.143928410772, 5544.362398324244, 5550.4449555044175, 5557.72211389437, 5569.637973531708, 5579.525740312119, 5832.387599302012, 5842.883142337215, 5844.240248767803, 5844.824655260349, 5875.794347197828, 3956.169204467094, 4006.777932730545, 4048.5748996356137, 4060.3352625423436, 4063.5530091689297, 5583.8883222336135, 5590.7763689453595, 5600.159976003632, 5603.607747457639, 5626.24045753818, 5479.452054794648, 5498.752556135064, 5519.31008623922, 5519.972400137974, 5521.641093328921, 5328.760205790826, 5420.349558052902, 5470.288862447856, 5483.890322193613, 5511.917321240265, 5461.235427040138, 5464.91802622953, 5472.507474327171, 5472.644278121909, 5480.753366098455, 5379.0, 5402.189671549299, 5504.559635229092, 5512.0, 5523.530499907552, 5316.494932981361, 5339.9466005341, 5363.329583802025, 5368.248445217595, 5382.381026182039], "value": 4244.892083527114, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [737.8302990312225, 751.2224847283063, 775.457179974018, 829.4981536170617, 838.9286910612598, 14947.626309342259, 15725.449609263678, 16098.59753506163, 16321.183940802943, 16399.262033208506, 14588.0, 14946.626334341647, 15058.849411505882, 15217.695646087072, 15372.923135384335, 758.2796343473681, 767.3477544087509, 769.0118198115423, 769.1769806307253, 769.7806125254303, 751.0536723728114, 768.4812751392816, 772.7604442622777, 773.5088218980932, 774.3843644302793, 803.4656953126193, 805.4160733468248, 806.330745481252, 808.8584497712906, 814.4054839966798, 806.1173015547995, 813.6460639621783, 814.1248158229897, 814.2386868278179, 814.3973459639824, 591.6479694581717, 596.0373995996478, 596.4453058655449, 596.58537316565, 597.2593983460521, 16352.918235408866, 16370.181490925406, 16390.344386224537, 16414.425495107615, 16894.577635559086, 14506.0, 14739.115653060744, 14867.479638212611, 14983.925080374638, 15396.615084622863, 11925.224860384047, 11935.761284774257, 12023.819642705366, 12146.757064858743, 12559.686007849878, 3537.2571759930447, 3599.9100022499647, 3720.6093360197333, 3725.497057897176, 3726.962730372689, 62041.37958620401, 65851.67074164598, 80597.0, 82506.17493825045, 83301.0, 11217.326960382403, 11373.431328433546, 11548.133889958286, 11639.418029098511, 11687.824682629767, 21307.147714091574, 21587.67618485724, 21814.672779908313, 21946.122155113935, 22032.779672203393, 8171.509709417335, 8180.427370084037, 8269.8346033079, 8365.07984121746, 8383.090873896319, 4203.495580530356, 4245.3631955206965, 4247.893802654959, 4271.23117838792, 4348.043430445297, 3663.2124093320062, 3734.514513113278, 3767.6232376762655, 3774.7923864187733, 3782.867599634, 618.3939739055661, 621.2482895696259, 624.0919462182604, 625.2996643759019, 635.9872802543923, 745.5042396806064, 760.8782594784808, 766.1534004924589, 794.9920500794918, 813.2680587471323, 10047.346922450017, 10158.241450663301, 11059.668209953714, 11091.39529652866, 11197.888021119847, 757.9583122928292, 763.9809004774814, 778.7741554949115, 810.7608255564622, 810.8580998325269, 4597.081930415264, 5024.145895197825, 5034.924476132861, 5046.174142480223, 5048.192289233705, 79868.0, 81571.5921420389, 82289.0, 82493.58753206316, 83836.0, 41338.586614134074, 44055.559444405786, 46047.0, 72124.0, 72267.0, 58428.4157158423, 60272.99999999912, 60524.0, 60629.0, 61269.387306126366, 9105.362624616479, 10669.859311660637, 11301.886981130083, 11305.660830175108, 11372.090232781193, 37730.0, 39874.60125398825, 40246.39630405605, 41381.58618413777, 41818.58181418147, 53673.19490207728, 56891.715541422025, 58205.84110180988, 58799.70600146972, 59380.70309648424, 11532.769344612892, 11586.884131158919, 11592.88407115918, 11666.88333116658, 12305.0, 11769.058475322125, 12324.075694322783, 14914.925425372803, 14928.850711492745, 15029.924850375679, 14436.783448248494, 14938.701225975203, 15078.396864125312, 15173.696526069638, 15450.30473628667, 13637.386317615532, 13963.650908727363, 13996.300184990507, 14487.710245795235, 14947.850521494645, 13531.526396576073, 13689.980571745815, 13826.170429774245, 14485.637859053608, 14669.266536673336, 11954.222975506564, 12085.94227150151, 12156.392180390769, 12312.445939932904, 12771.61685149447, 10510.527026283988, 10656.520456579317, 11187.32876027441, 11796.823047654121, 12259.448324825582], "value": 7277.707333759719, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1499.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 111.0, 112.0, 112.0, 112.0, 112.0, 112.0, 114.0, 113.0, 113.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 119.0, 118.0, 169.0, 120.0, 120.0, 118.0, 118.0, 147.0, 119.0], "value": 129.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 160.0, 160.0, 160.0, 161.0, 161.0, 161.0, 161.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 106.0, 78.0, 76.0, 75.0, 74.0, 99.0, 76.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 116.0, 83.0, 83.0, 83.0, 106.0, 83.0, 83.0, 114.0], "value": 91.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 97.0, 97.0, 95.0, 96.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 53.0, 55.0, 55.0, 55.0, 54.0, 55.0, 54.0, 55.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 63.0, 63.0, 62.0, 63.0, 67.0, 63.0, 63.0], "value": 63.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 83.0, 82.0, 82.0, 82.0, 84.0, 82.0, 81.0, 82.0], "value": 82.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 130.0, 126.0, 126.0, 139.0, 127.0, 125.0, 132.0, 170.0, 142.0], "value": 134.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 168.0, 168.0, 167.0, 168.0, 169.0, 166.0, 174.0, 166.0, 168.0], "value": 168.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 65.0, 63.0, 62.0, 62.0, 62.0, 63.0, 61.0, 62.0, 61.0], "value": 63.1, "unit": "score"}]}]} 05:20:16 INFO - Return code: 0 05:20:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:20:16 ERROR - # TBPL SUCCESS # 05:20:16 INFO - Running post-action listener: _resource_record_post_action 05:20:16 INFO - [mozharness: 2017-02-06 13:20:16.611666Z] Finished run-tests step (success) 05:20:16 INFO - Running post-run listener: _resource_record_post_run 05:20:16 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 40960; Write bytes: 401149952; Read time: 52; Write time: 295592 05:20:16 INFO - TinderboxPrint: CPU usage
13.0% 05:20:16 INFO - TinderboxPrint: I/O read bytes / time
40,960 / 52 05:20:16 INFO - TinderboxPrint: I/O write bytes / time
401,149,952 / 295,592 05:20:16 INFO - TinderboxPrint: CPU idle
8,299.4 (86.9%) 05:20:16 INFO - TinderboxPrint: CPU user
1,199.4 (12.6%) 05:20:16 INFO - TinderboxPrint: Swap in / out
0 / 0 05:20:16 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 105738240; Read time: 0; Write time: 92448 05:20:16 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 40960; Write bytes: 295403520; Read time: 52; Write time: 203144 05:20:17 INFO - Running post-run listener: _upload_blobber_files 05:20:17 INFO - Blob upload gear active. 05:20:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:20:17 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:20:17 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'] 05:20:17 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 05:20:17 INFO - (blobuploader) - INFO - Open directory for files ... 05:20:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:20:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:20:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:20:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:20:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:20:22 INFO - (blobuploader) - INFO - Done attempting. 05:20:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:20:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:20:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:20:23 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:20:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:20:23 INFO - (blobuploader) - INFO - Done attempting. 05:20:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:20:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:20:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:20:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:20:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:20:24 INFO - (blobuploader) - INFO - Done attempting. 05:20:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:20:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:20:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:20:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:20:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:20:24 INFO - (blobuploader) - INFO - Done attempting. 05:20:24 INFO - (blobuploader) - INFO - Iteration through files over. 05:20:24 INFO - Return code: 0 05:20:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:20:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:20:24 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b09c495465db8e15f74e9ab22641ba385d29dea4a53cd93cf2d88d6ba15f4e0a6dcea3076740c04a46251c1c7172bdefa3c74b28046a3244a56b43991276e6c1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0d79f61fd46e64c446f03028901474ddabdda103e76435a248e4c5c533256d4ac42dd3c131b10d9a28fcd42a0b9869801d77443c089b341a5f1bef5efd9c6ab1", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/62fbf728d3c47402f9cbafa50295f3617fcb53c0ea2d1e8bbcdd3feaaac58401029aee32cd03ae6b2d1d566b88d94a98c66e8f14b11c4553ed28756a9ca38742", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/27c07bea26ecdd5298bcd47ad8f1188fc3a8790f774437ab3245887491a4174b33c2c64bb75299fc19b8b0f0ae9e018dd80f947368dc0dfb70c56ba8474f592e"} 05:20:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:20:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:20:24 INFO - Contents: 05:20:24 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b09c495465db8e15f74e9ab22641ba385d29dea4a53cd93cf2d88d6ba15f4e0a6dcea3076740c04a46251c1c7172bdefa3c74b28046a3244a56b43991276e6c1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0d79f61fd46e64c446f03028901474ddabdda103e76435a248e4c5c533256d4ac42dd3c131b10d9a28fcd42a0b9869801d77443c089b341a5f1bef5efd9c6ab1", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/62fbf728d3c47402f9cbafa50295f3617fcb53c0ea2d1e8bbcdd3feaaac58401029aee32cd03ae6b2d1d566b88d94a98c66e8f14b11c4553ed28756a9ca38742", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/27c07bea26ecdd5298bcd47ad8f1188fc3a8790f774437ab3245887491a4174b33c2c64bb75299fc19b8b0f0ae9e018dd80f947368dc0dfb70c56ba8474f592e"} 05:20:24 INFO - Running post-run listener: copy_logs_to_upload_dir 05:20:24 INFO - Copying logs to upload dir... 05:20:24 INFO - mkdir: /builds/slave/test/build/upload/logs 05:20:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.424606 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2017-02-06 05:20:24.910477) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-06 05:20:24.914578) ========= 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=20e666a3d4cfbb71505a330e000001b4-1486385980.116267-93126986 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b09c495465db8e15f74e9ab22641ba385d29dea4a53cd93cf2d88d6ba15f4e0a6dcea3076740c04a46251c1c7172bdefa3c74b28046a3244a56b43991276e6c1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0d79f61fd46e64c446f03028901474ddabdda103e76435a248e4c5c533256d4ac42dd3c131b10d9a28fcd42a0b9869801d77443c089b341a5f1bef5efd9c6ab1", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/62fbf728d3c47402f9cbafa50295f3617fcb53c0ea2d1e8bbcdd3feaaac58401029aee32cd03ae6b2d1d566b88d94a98c66e8f14b11c4553ed28756a9ca38742", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/27c07bea26ecdd5298bcd47ad8f1188fc3a8790f774437ab3245887491a4174b33c2c64bb75299fc19b8b0f0ae9e018dd80f947368dc0dfb70c56ba8474f592e"} build_url:https://queue.taskcluster.net/v1/task/VO4h69AGST2XKTj92I1ebQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011244 build_url: 'https://queue.taskcluster.net/v1/task/VO4h69AGST2XKTj92I1ebQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b09c495465db8e15f74e9ab22641ba385d29dea4a53cd93cf2d88d6ba15f4e0a6dcea3076740c04a46251c1c7172bdefa3c74b28046a3244a56b43991276e6c1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0d79f61fd46e64c446f03028901474ddabdda103e76435a248e4c5c533256d4ac42dd3c131b10d9a28fcd42a0b9869801d77443c089b341a5f1bef5efd9c6ab1", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/62fbf728d3c47402f9cbafa50295f3617fcb53c0ea2d1e8bbcdd3feaaac58401029aee32cd03ae6b2d1d566b88d94a98c66e8f14b11c4553ed28756a9ca38742", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/27c07bea26ecdd5298bcd47ad8f1188fc3a8790f774437ab3245887491a4174b33c2c64bb75299fc19b8b0f0ae9e018dd80f947368dc0dfb70c56ba8474f592e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-06 05:20:24.939447) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 05:20:24.939823) ========= 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=20e666a3d4cfbb71505a330e000001b4-1486385980.116267-93126986 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004458 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 05:20:25.023942) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-06 05:20:25.024300) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-06 05:20:25.024644) ========= ========= Total master_lag: 0.17 =========