builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-042 starttime: 1490829396.96 results: success (0) revision: fc2eda92be4091d5ea0828f51fe4aaee41ed8319 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-29 16:16:36.958351) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-29 16:16:36.958786) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-29 16:16:36.959102) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-29 16:16:36.974332) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 16:16:36.974898) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1490829396.431613-2121658179 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-29 16:16:37-- 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% 54.1M=0s 2017-03-29 16:16:37 (54.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.084074 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 16:16:37.074324) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 16:16:37.074677) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1490829396.431613-2121658179 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020730 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 16:16:37.125271) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-29 16:16:37.125706) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev fc2eda92be4091d5ea0828f51fe4aaee41ed8319 --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 fc2eda92be4091d5ea0828f51fe4aaee41ed8319 --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=74d6aec007b0fa31a864ebd7000001f8-1490829396.431613-2121658179 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-29 16:16:37,376 truncating revision to first 12 chars 2017-03-29 16:16:37,376 Setting DEBUG logging. 2017-03-29 16:16:37,376 attempt 1/10 2017-03-29 16:16:37,376 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/fc2eda92be40?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-29 16:16:38,707 unpacking tar archive at: mozilla-central-fc2eda92be40/testing/mozharness/ program finished with exit code 0 elapsedTime=1.603568 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-29 16:16:38.744614) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-29 16:16:38.744929) ========= script_repo_revision: fc2eda92be4091d5ea0828f51fe4aaee41ed8319 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-29 16:16:38.745300) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-29 16:16:38.745563) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-29 16:16:38.755479) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-03-29 16:16:38.755760) ========= /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=74d6aec007b0fa31a864ebd7000001f8-1490829396.431613-2121658179 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:16:39 INFO - MultiFileLogger online at 20170329 16:16:39 in /builds/slave/test 16:16:39 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 16:16:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:16:39 INFO - {'append_to_log': False, 16:16:39 INFO - 'base_work_dir': '/builds/slave/test', 16:16:39 INFO - 'blob_upload_branch': 'Firefox', 16:16:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:16:39 INFO - 'branch': 'Firefox', 16:16:39 INFO - 'buildbot_json_path': 'buildprops.json', 16:16:39 INFO - 'config_files': ('talos/linux_config.py',), 16:16:39 INFO - 'default_actions': ('clobber', 16:16:39 INFO - 'read-buildbot-config', 16:16:39 INFO - 'download-and-extract', 16:16:39 INFO - 'populate-webroot', 16:16:39 INFO - 'create-virtualenv', 16:16:39 INFO - 'install', 16:16:39 INFO - 'run-tests'), 16:16:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:16:39 INFO - 'download_minidump_stackwalk': True, 16:16:39 INFO - 'download_symbols': 'ondemand', 16:16:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:16:39 INFO - 'tooltool.py': '/tools/tooltool.py', 16:16:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:16:39 INFO - '/tools/misc-python/virtualenv.py')}, 16:16:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:16:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:16:39 INFO - 'gecko_profile': False, 16:16:39 INFO - 'gecko_profile_interval': 0, 16:16:39 INFO - 'installer_path': 'installer.exe', 16:16:39 INFO - 'log_level': 'info', 16:16:39 INFO - 'log_name': 'talos', 16:16:39 INFO - 'log_to_console': True, 16:16:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:16:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:16:39 INFO - 'opt_config_files': (), 16:16:39 INFO - 'pip_index': False, 16:16:39 INFO - 'suite': 'dromaeojs', 16:16:39 INFO - 'system_bits': '32', 16:16:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:16:39 INFO - 'title': 'talos-linux64-ix-042', 16:16:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:16:39 INFO - 'use_talos_json': True, 16:16:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:16:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:16:39 INFO - 'work_dir': 'build'} 16:16:39 INFO - [mozharness: 2017-03-29 23:16:39.108671Z] Running clobber step. 16:16:39 INFO - Running pre-action listener: _resource_record_pre_action 16:16:39 INFO - Running main action method: clobber 16:16:39 INFO - rmtree: /builds/slave/test/build 16:16:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:16:40 INFO - Running post-action listener: _resource_record_post_action 16:16:40 INFO - [mozharness: 2017-03-29 23:16:40.600927Z] Finished clobber step (success) 16:16:40 INFO - [mozharness: 2017-03-29 23:16:40.601032Z] Running read-buildbot-config step. 16:16:40 INFO - Running pre-action listener: _resource_record_pre_action 16:16:40 INFO - Running main action method: read_buildbot_config 16:16:40 INFO - Using buildbot properties: 16:16:40 INFO - { 16:16:40 INFO - "project": "", 16:16:40 INFO - "product": "firefox", 16:16:40 INFO - "who": "kwierso@gmail.com", 16:16:40 INFO - "installer_path": "public/build/target.tar.bz2", 16:16:40 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 16:16:40 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 16:16:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 16:16:40 INFO - "stage_platform": "linux64-pgo", 16:16:40 INFO - "basedir": "/builds/slave/test", 16:16:40 INFO - "buildnumber": 103, 16:16:40 INFO - "platform": "ubuntu64_hw", 16:16:40 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:16:40 INFO - "slavebuilddir": "test", 16:16:40 INFO - "taskId": "M_UD7SdbRSiFziPZrqD05g", 16:16:40 INFO - "branch": "mozilla-central", 16:16:40 INFO - "script_repo_revision": "production", 16:16:40 INFO - "revision": "fc2eda92be4091d5ea0828f51fe4aaee41ed8319", 16:16:40 INFO - "slavename": "talos-linux64-ix-042", 16:16:40 INFO - "repo_path": "mozilla-central" 16:16:40 INFO - } 16:16:40 INFO - Finding installer, test and symbols from parent task. 16:16:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M_UD7SdbRSiFziPZrqD05g'}, attempt #1 16:16:41 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M_UD7SdbRSiFziPZrqD05g'}, attempt #1 16:16:41 INFO - Task dependencies: frqLWP9oTZquTIy_-idEqg 16:16:41 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/frqLWP9oTZquTIy_-idEqg'}, attempt #1 16:16:42 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/frqLWP9oTZquTIy_-idEqg/artifacts/public/build/target.tar.bz2 16:16:42 INFO - Set test_url: https://queue.taskcluster.net/v1/task/frqLWP9oTZquTIy_-idEqg/artifacts/public/build/test_packages.json 16:16:42 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/frqLWP9oTZquTIy_-idEqg/artifacts/public/build/target.crashreporter-symbols.zip 16:16:42 INFO - Running post-action listener: _resource_record_post_action 16:16:42 INFO - [mozharness: 2017-03-29 23:16:42.003519Z] Finished read-buildbot-config step (success) 16:16:42 INFO - [mozharness: 2017-03-29 23:16:42.003739Z] Running download-and-extract step. 16:16:42 INFO - Running pre-action listener: _resource_record_pre_action 16:16:42 INFO - Running main action method: download_and_extract 16:16:42 INFO - mkdir: /builds/slave/test/build/tests 16:16:42 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')]} 16:16:42 INFO - trying https://queue.taskcluster.net/v1/task/frqLWP9oTZquTIy_-idEqg/artifacts/public/build/target.test_packages.json 16:16:42 INFO - Downloading https://queue.taskcluster.net/v1/task/frqLWP9oTZquTIy_-idEqg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:16:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/frqLWP9oTZquTIy_-idEqg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:16:42 INFO - Downloaded 986 bytes. 16:16:42 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:16:42 INFO - Using the following test package requirements: 16:16:42 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:16:42 INFO - u'common': [u'target.common.tests.zip'], 16:16:42 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:16:42 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:16:42 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:16:42 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:16:42 INFO - u'mozbase': [u'target.common.tests.zip'], 16:16:42 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:16:42 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:16:42 INFO - u'web-platform': [u'target.common.tests.zip', 16:16:42 INFO - u'target.web-platform.tests.zip'], 16:16:42 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:16:42 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 16:16:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/frqLWP9oTZquTIy_-idEqg/artifacts/public/build/target.common.tests.zip 16:16:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/frqLWP9oTZquTIy_-idEqg/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:16:42 INFO - Fetch https://queue.taskcluster.net/v1/task/frqLWP9oTZquTIy_-idEqg/artifacts/public/build/target.common.tests.zip into memory 16:16:43 INFO - Expected file size: 60353555 16:16:43 INFO - Obtained file size: 60353555 16:16:53 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 16:16:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/frqLWP9oTZquTIy_-idEqg/artifacts/public/build/target.common.tests.zip 16:16:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/frqLWP9oTZquTIy_-idEqg/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:16:53 INFO - Fetch https://queue.taskcluster.net/v1/task/frqLWP9oTZquTIy_-idEqg/artifacts/public/build/target.common.tests.zip into memory 16:16:54 INFO - Expected file size: 60353555 16:16:54 INFO - Obtained file size: 60353555 16:17:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/frqLWP9oTZquTIy_-idEqg/artifacts/public/build/target.talos.tests.zip 16:17:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/frqLWP9oTZquTIy_-idEqg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:17:05 INFO - Fetch https://queue.taskcluster.net/v1/task/frqLWP9oTZquTIy_-idEqg/artifacts/public/build/target.talos.tests.zip into memory 16:17:06 INFO - Expected file size: 14404171 16:17:06 INFO - Obtained file size: 14404171 16:17:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:17:06 INFO - trying https://queue.taskcluster.net/v1/task/frqLWP9oTZquTIy_-idEqg/artifacts/public/build/target.tar.bz2 16:17:06 INFO - Downloading https://queue.taskcluster.net/v1/task/frqLWP9oTZquTIy_-idEqg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:17:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/frqLWP9oTZquTIy_-idEqg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:17:07 INFO - Downloaded 67962041 bytes. 16:17:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/frqLWP9oTZquTIy_-idEqg/artifacts/public/build/target.tar.bz2 16:17:07 INFO - mkdir: /builds/slave/test/properties 16:17:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:17:07 INFO - Writing to file /builds/slave/test/properties/build_url 16:17:07 INFO - Contents: 16:17:07 INFO - build_url:https://queue.taskcluster.net/v1/task/frqLWP9oTZquTIy_-idEqg/artifacts/public/build/target.tar.bz2 16:17:07 INFO - Running post-action listener: _resource_record_post_action 16:17:07 INFO - Running post-action listener: set_extra_try_arguments 16:17:07 INFO - [mozharness: 2017-03-29 23:17:07.875135Z] Finished download-and-extract step (success) 16:17:07 INFO - [mozharness: 2017-03-29 23:17:07.875233Z] Running populate-webroot step. 16:17:07 INFO - Running pre-action listener: _resource_record_pre_action 16:17:07 INFO - Running main action method: populate_webroot 16:17:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:17:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:17:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:17:07 INFO - '--tppagecycles', 16:17:07 INFO - '7'], 16:17:07 INFO - 'tests': ['tsvgm']}}, 16:17:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:17:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:17:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:17:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:17:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:17:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:17:07 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:17:07 INFO - 'talos_options': ['--disable-e10s'], 16:17:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:17:07 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:17:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:17:07 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:17:07 INFO - 'talos_options': ['--disable-e10s'], 16:17:07 INFO - 'tests': ['damp', 'tps']}, 16:17:07 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:17:07 INFO - 'tests': ['damp', 'tps']}, 16:17:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:17:07 INFO - 'tests': ['dromaeo_dom']}, 16:17:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:17:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:17:07 INFO - 'tests': ['basic_compositor_video']}, 16:17:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:17:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:17:07 INFO - 'tests': ['a11yr', 16:17:07 INFO - 'ts_paint', 16:17:07 INFO - 'tpaint', 16:17:07 INFO - 'sessionrestore', 16:17:07 INFO - 'sessionrestore_no_auto_restore', 16:17:07 INFO - 'tabpaint']}, 16:17:07 INFO - 'other-e10s': {'tests': ['a11yr', 16:17:07 INFO - 'ts_paint', 16:17:07 INFO - 'tpaint', 16:17:07 INFO - 'sessionrestore', 16:17:07 INFO - 'sessionrestore_no_auto_restore', 16:17:07 INFO - 'tabpaint']}, 16:17:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:17:07 INFO - 'ts_paint', 16:17:07 INFO - 'tpaint', 16:17:07 INFO - 'sessionrestore', 16:17:07 INFO - 'sessionrestore_no_auto_restore', 16:17:07 INFO - 'tabpaint']}, 16:17:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:17:07 INFO - 'ts_paint', 16:17:07 INFO - 'tpaint', 16:17:07 INFO - 'sessionrestore', 16:17:07 INFO - 'sessionrestore_no_auto_restore', 16:17:07 INFO - 'tabpaint']}, 16:17:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:17:07 INFO - 'tests': ['a11yr', 16:17:07 INFO - 'ts_paint', 16:17:07 INFO - 'tpaint', 16:17:07 INFO - 'sessionrestore', 16:17:07 INFO - 'sessionrestore_no_auto_restore', 16:17:07 INFO - 'tabpaint']}, 16:17:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:17:07 INFO - 'tests': ['a11yr', 16:17:07 INFO - 'ts_paint', 16:17:07 INFO - 'tpaint', 16:17:07 INFO - 'sessionrestore', 16:17:07 INFO - 'sessionrestore_no_auto_restore', 16:17:07 INFO - 'tabpaint']}, 16:17:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:17:07 INFO - 'tests': ['tsvgx', 16:17:07 INFO - 'tsvgr_opacity', 16:17:07 INFO - 'tart', 16:17:07 INFO - 'tscrollx', 16:17:07 INFO - 'cart', 16:17:07 INFO - 'tsvg_static']}, 16:17:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:17:07 INFO - 'tsvgr_opacity', 16:17:07 INFO - 'tart', 16:17:07 INFO - 'tscrollx', 16:17:07 INFO - 'cart', 16:17:07 INFO - 'tsvg_static']}, 16:17:07 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:17:07 INFO - 'talos_options': ['--disable-e10s'], 16:17:07 INFO - 'tests': ['tp5o']}, 16:17:07 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:17:07 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:17:07 INFO - 'talos_options': ['--disable-e10s', 16:17:07 INFO - '--xperf_path', 16:17:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:17:07 INFO - 'tests': ['tp5n']}, 16:17:07 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:17:07 INFO - 'talos_options': ['--xperf_path', 16:17:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:17:07 INFO - 'tests': ['tp5n']}}, 16:17:07 INFO - 'talos.zip': {'path': '', 16:17:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:17:07 INFO - Running post-action listener: _resource_record_post_action 16:17:07 INFO - [mozharness: 2017-03-29 23:17:07.888600Z] Finished populate-webroot step (success) 16:17:07 INFO - [mozharness: 2017-03-29 23:17:07.888691Z] Running create-virtualenv step. 16:17:07 INFO - Running pre-action listener: _resource_record_pre_action 16:17:07 INFO - Running main action method: create_virtualenv 16:17:07 INFO - Creating virtualenv /builds/slave/test/build/venv 16:17:07 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 16:17:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:17:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:17:07 INFO - Using real prefix '/usr' 16:17:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:17:08 INFO - Installing distribute.............................................................................................................................................................................................done. 16:17:10 INFO - Installing pip.................done. 16:17:10 INFO - Return code: 0 16:17:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:17:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:17:10 INFO - Reading from file tmpfile_stdout 16:17:10 INFO - Output received: 16:17:10 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) 16:17:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:17:10 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')]} 16:17:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:17:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:10 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')]} 16:17:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:17:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:10 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 0xe671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1105310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102400>, '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 0x11033b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103840>, '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': '74d6aec007b0fa31a864ebd7000001f8-1490829396.431613-2121658179', '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 16:17:10 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 16:17:10 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 16:17:10 INFO - Using env: {'DISPLAY': ':0', 16:17:10 INFO - 'HOME': '/home/cltbld', 16:17:10 INFO - 'LANG': 'en_US.UTF-8', 16:17:10 INFO - 'LANGUAGE': 'en_US:en', 16:17:10 INFO - 'LOGNAME': 'cltbld', 16:17:10 INFO - 'MAIL': '/var/mail/cltbld', 16:17:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:17:10 INFO - 'MOZ_NO_REMOTE': '1', 16:17:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:17:10 INFO - 'NO_EM_RESTART': '1', 16:17:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:17:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:17:10 INFO - 'PWD': '/builds/slave/test', 16:17:10 INFO - 'SHELL': '/bin/bash', 16:17:10 INFO - 'SHLVL': '1', 16:17:10 INFO - 'TERM': 'linux', 16:17:10 INFO - 'TMOUT': '86400', 16:17:10 INFO - 'USER': 'cltbld', 16:17:10 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1490829396.431613-2121658179', 16:17:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:17:10 INFO - '_': '/tools/buildbot/bin/python'} 16:17:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:17:10 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 16:17:10 INFO - Cleaning up... 16:17:10 INFO - Return code: 0 16:17:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:17:10 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')]} 16:17:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:17:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:10 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')]} 16:17:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:17:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:10 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 0xe671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1105310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102400>, '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 0x11033b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103840>, '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': '74d6aec007b0fa31a864ebd7000001f8-1490829396.431613-2121658179', '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 16:17:10 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 16:17:10 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 16:17:10 INFO - Using env: {'DISPLAY': ':0', 16:17:10 INFO - 'HOME': '/home/cltbld', 16:17:10 INFO - 'LANG': 'en_US.UTF-8', 16:17:10 INFO - 'LANGUAGE': 'en_US:en', 16:17:10 INFO - 'LOGNAME': 'cltbld', 16:17:10 INFO - 'MAIL': '/var/mail/cltbld', 16:17:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:17:10 INFO - 'MOZ_NO_REMOTE': '1', 16:17:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:17:10 INFO - 'NO_EM_RESTART': '1', 16:17:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:17:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:17:10 INFO - 'PWD': '/builds/slave/test', 16:17:10 INFO - 'SHELL': '/bin/bash', 16:17:10 INFO - 'SHLVL': '1', 16:17:10 INFO - 'TERM': 'linux', 16:17:10 INFO - 'TMOUT': '86400', 16:17:10 INFO - 'USER': 'cltbld', 16:17:10 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1490829396.431613-2121658179', 16:17:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:17:10 INFO - '_': '/tools/buildbot/bin/python'} 16:17:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:17:11 INFO - Downloading/unpacking psutil>=3.1.1 16:17: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 16:17: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 16:17: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 16:17: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 16:17: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 16:17: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 16:17:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:17:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:17:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:17:13 INFO - Installing collected packages: psutil 16:17:13 INFO - Running setup.py install for psutil 16:17:13 INFO - building 'psutil._psutil_linux' extension 16:17:13 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 16:17:13 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 16:17:13 INFO - building 'psutil._psutil_posix' extension 16:17:13 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 16:17:13 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 16:17:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:17:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:17:13 INFO - Successfully installed psutil 16:17:13 INFO - Cleaning up... 16:17:13 INFO - Return code: 0 16:17:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:17:13 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')]} 16:17:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:17:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:13 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')]} 16:17:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:17:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:13 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 0xe671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1105310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102400>, '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 0x11033b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103840>, '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': '74d6aec007b0fa31a864ebd7000001f8-1490829396.431613-2121658179', '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 16:17:13 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 16:17:13 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 16:17:13 INFO - Using env: {'DISPLAY': ':0', 16:17:13 INFO - 'HOME': '/home/cltbld', 16:17:13 INFO - 'LANG': 'en_US.UTF-8', 16:17:13 INFO - 'LANGUAGE': 'en_US:en', 16:17:13 INFO - 'LOGNAME': 'cltbld', 16:17:13 INFO - 'MAIL': '/var/mail/cltbld', 16:17:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:17:13 INFO - 'MOZ_NO_REMOTE': '1', 16:17:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:17:13 INFO - 'NO_EM_RESTART': '1', 16:17:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:17:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:17:13 INFO - 'PWD': '/builds/slave/test', 16:17:13 INFO - 'SHELL': '/bin/bash', 16:17:13 INFO - 'SHLVL': '1', 16:17:13 INFO - 'TERM': 'linux', 16:17:13 INFO - 'TMOUT': '86400', 16:17:13 INFO - 'USER': 'cltbld', 16:17:13 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1490829396.431613-2121658179', 16:17:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:17:13 INFO - '_': '/tools/buildbot/bin/python'} 16:17:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:17:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:17:13 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 16:17:13 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 16:17:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:17:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:17:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:17:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:17:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:17:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:17:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:17:16 INFO - Installing collected packages: mozsystemmonitor 16:17:16 INFO - Running setup.py install for mozsystemmonitor 16:17:16 INFO - Successfully installed mozsystemmonitor 16:17:16 INFO - Cleaning up... 16:17:16 INFO - Return code: 0 16:17:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:17:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:17:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:17:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:17:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1105310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102400>, '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 0x11033b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103840>, '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': '74d6aec007b0fa31a864ebd7000001f8-1490829396.431613-2121658179', '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 16:17:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:17:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:17:16 INFO - Using env: {'DISPLAY': ':0', 16:17:16 INFO - 'HOME': '/home/cltbld', 16:17:16 INFO - 'LANG': 'en_US.UTF-8', 16:17:16 INFO - 'LANGUAGE': 'en_US:en', 16:17:16 INFO - 'LOGNAME': 'cltbld', 16:17:16 INFO - 'MAIL': '/var/mail/cltbld', 16:17:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:17:16 INFO - 'MOZ_NO_REMOTE': '1', 16:17:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:17:16 INFO - 'NO_EM_RESTART': '1', 16:17:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:17:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:17:16 INFO - 'PWD': '/builds/slave/test', 16:17:16 INFO - 'SHELL': '/bin/bash', 16:17:16 INFO - 'SHLVL': '1', 16:17:16 INFO - 'TERM': 'linux', 16:17:16 INFO - 'TMOUT': '86400', 16:17:16 INFO - 'USER': 'cltbld', 16:17:16 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1490829396.431613-2121658179', 16:17:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:17:16 INFO - '_': '/tools/buildbot/bin/python'} 16:17:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:17:16 INFO - Downloading/unpacking jsonschema==2.5.1 16:17:16 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 16:17:16 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 16:17:16 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 16:17:16 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 16:17:16 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 16:17:16 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 16:17:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:17:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:17:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:17:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:17:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:17:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:17:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:17:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:17:18 INFO - Downloading functools32-3.2.3-2.tar.gz 16:17:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:17:18 INFO - warning: no files found matching '*.txt' 16:17:18 INFO - no previously-included directories found matching 'build' 16:17:18 INFO - no previously-included directories found matching 'dist' 16:17:18 INFO - no previously-included directories found matching '.git*' 16:17:18 INFO - Installing collected packages: jsonschema, functools32 16:17:18 INFO - Running setup.py install for functools32 16:17:18 INFO - warning: no files found matching '*.txt' 16:17:18 INFO - no previously-included directories found matching 'build' 16:17:18 INFO - no previously-included directories found matching 'dist' 16:17:18 INFO - no previously-included directories found matching '.git*' 16:17:18 INFO - Successfully installed jsonschema functools32 16:17:18 INFO - Cleaning up... 16:17:18 INFO - Return code: 0 16:17:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:17:18 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')]} 16:17:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:17:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:18 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')]} 16:17:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:17:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:18 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 0xe671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1105310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102400>, '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 0x11033b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103840>, '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': '74d6aec007b0fa31a864ebd7000001f8-1490829396.431613-2121658179', '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 16:17:18 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 16:17:18 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 16:17:18 INFO - Using env: {'DISPLAY': ':0', 16:17:18 INFO - 'HOME': '/home/cltbld', 16:17:18 INFO - 'LANG': 'en_US.UTF-8', 16:17:18 INFO - 'LANGUAGE': 'en_US:en', 16:17:18 INFO - 'LOGNAME': 'cltbld', 16:17:18 INFO - 'MAIL': '/var/mail/cltbld', 16:17:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:17:18 INFO - 'MOZ_NO_REMOTE': '1', 16:17:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:17:18 INFO - 'NO_EM_RESTART': '1', 16:17:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:17:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:17:18 INFO - 'PWD': '/builds/slave/test', 16:17:18 INFO - 'SHELL': '/bin/bash', 16:17:18 INFO - 'SHLVL': '1', 16:17:18 INFO - 'TERM': 'linux', 16:17:18 INFO - 'TMOUT': '86400', 16:17:18 INFO - 'USER': 'cltbld', 16:17:18 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1490829396.431613-2121658179', 16:17:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:17:18 INFO - '_': '/tools/buildbot/bin/python'} 16:17:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:17:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:17:19 INFO - Cleaning up... 16:17:19 INFO - Return code: 0 16:17:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:17: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')]} 16:17:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:17:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17: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')]} 16:17:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:17:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1105310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102400>, '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 0x11033b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103840>, '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': '74d6aec007b0fa31a864ebd7000001f8-1490829396.431613-2121658179', '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 16:17:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:17:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:17:19 INFO - Using env: {'DISPLAY': ':0', 16:17:19 INFO - 'HOME': '/home/cltbld', 16:17:19 INFO - 'LANG': 'en_US.UTF-8', 16:17:19 INFO - 'LANGUAGE': 'en_US:en', 16:17:19 INFO - 'LOGNAME': 'cltbld', 16:17:19 INFO - 'MAIL': '/var/mail/cltbld', 16:17:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:17:19 INFO - 'MOZ_NO_REMOTE': '1', 16:17:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:17:19 INFO - 'NO_EM_RESTART': '1', 16:17:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:17:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:17:19 INFO - 'PWD': '/builds/slave/test', 16:17:19 INFO - 'SHELL': '/bin/bash', 16:17:19 INFO - 'SHLVL': '1', 16:17:19 INFO - 'TERM': 'linux', 16:17:19 INFO - 'TMOUT': '86400', 16:17:19 INFO - 'USER': 'cltbld', 16:17:19 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1490829396.431613-2121658179', 16:17:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:17:19 INFO - '_': '/tools/buildbot/bin/python'} 16:17:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:17:19 INFO - Downloading/unpacking blobuploader==1.2.4 16:17:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:17:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:17:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:17:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:17:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:17:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:17:21 INFO - Downloading blobuploader-1.2.4.tar.gz 16:17:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:17:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:17:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:17:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:17:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:17:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:17:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:17:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:17:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:17:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:17:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:17:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:17:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:17:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:17:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:17:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:17:22 INFO - Downloading docopt-0.6.1.tar.gz 16:17:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:17:22 INFO - Installing collected packages: blobuploader, requests, docopt 16:17:22 INFO - Running setup.py install for blobuploader 16:17:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:17:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:17:22 INFO - Running setup.py install for requests 16:17:22 INFO - Running setup.py install for docopt 16:17:22 INFO - Successfully installed blobuploader requests docopt 16:17:22 INFO - Cleaning up... 16:17:22 INFO - Return code: 0 16:17:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:17:22 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')]} 16:17:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:17:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:22 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')]} 16:17:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:17:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:22 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 0xe671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1105310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102400>, '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 0x11033b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103840>, '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': '74d6aec007b0fa31a864ebd7000001f8-1490829396.431613-2121658179', '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 16:17:22 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 16:17:22 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 16:17:22 INFO - Using env: {'DISPLAY': ':0', 16:17:22 INFO - 'HOME': '/home/cltbld', 16:17:22 INFO - 'LANG': 'en_US.UTF-8', 16:17:22 INFO - 'LANGUAGE': 'en_US:en', 16:17:22 INFO - 'LOGNAME': 'cltbld', 16:17:22 INFO - 'MAIL': '/var/mail/cltbld', 16:17:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:17:22 INFO - 'MOZ_NO_REMOTE': '1', 16:17:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:17:22 INFO - 'NO_EM_RESTART': '1', 16:17:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:17:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:17:22 INFO - 'PWD': '/builds/slave/test', 16:17:22 INFO - 'SHELL': '/bin/bash', 16:17:22 INFO - 'SHLVL': '1', 16:17:22 INFO - 'TERM': 'linux', 16:17:22 INFO - 'TMOUT': '86400', 16:17:22 INFO - 'USER': 'cltbld', 16:17:22 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1490829396.431613-2121658179', 16:17:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:17:22 INFO - '_': '/tools/buildbot/bin/python'} 16:17:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:17:22 INFO - Running setup.py (path:/tmp/pip-hhF94w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:17:23 INFO - Running setup.py (path:/tmp/pip-4bP4Jr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:17:23 INFO - Running setup.py (path:/tmp/pip-3VkPKg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:17:23 INFO - Running setup.py (path:/tmp/pip-Put2J2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:17:23 INFO - Running setup.py (path:/tmp/pip-KNkwoB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:17:23 INFO - Running setup.py (path:/tmp/pip-zG8rNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:17:23 INFO - Running setup.py (path:/tmp/pip-X2MDYm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:17:23 INFO - Running setup.py (path:/tmp/pip-qAUL0A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:17:23 INFO - Running setup.py (path:/tmp/pip-zo45r9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:17:23 INFO - Running setup.py (path:/tmp/pip-0hvK3h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:17:23 INFO - Running setup.py (path:/tmp/pip-mqz9cN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:17:23 INFO - Running setup.py (path:/tmp/pip-j5zqPj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:17:23 INFO - Running setup.py (path:/tmp/pip-qWzeCg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:17:23 INFO - Running setup.py (path:/tmp/pip-GRswzB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:17:23 INFO - Running setup.py (path:/tmp/pip-Qn04GI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:17:24 INFO - Running setup.py (path:/tmp/pip-hdFqSn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:17:24 INFO - Running setup.py (path:/tmp/pip-BlWJEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:17:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:17:24 INFO - Running setup.py install for manifestparser 16:17:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:17:24 INFO - Running setup.py install for mozcrash 16:17:24 INFO - Running setup.py install for mozdebug 16:17:24 INFO - Running setup.py install for mozdevice 16:17:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:17:24 INFO - Running setup.py install for mozfile 16:17:24 INFO - Running setup.py install for mozhttpd 16:17:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:17:24 INFO - Running setup.py install for mozinfo 16:17:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:17:24 INFO - Running setup.py install for mozInstall 16:17:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:17:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:17:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:17:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:17:24 INFO - Running setup.py install for mozleak 16:17:25 INFO - Running setup.py install for mozlog 16:17:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:17:25 INFO - Running setup.py install for moznetwork 16:17:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:17:25 INFO - Running setup.py install for mozprocess 16:17:25 INFO - Running setup.py install for mozprofile 16:17:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:17:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:17:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:17:25 INFO - Running setup.py install for mozrunner 16:17:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:17:25 INFO - Running setup.py install for mozscreenshot 16:17:25 INFO - Running setup.py install for moztest 16:17:25 INFO - Running setup.py install for mozversion 16:17:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:17:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:17:25 INFO - Cleaning up... 16:17:25 INFO - Return code: 0 16:17:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:17:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:17:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:17:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:17:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:17:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:25 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 0xe671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1105310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102400>, '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 0x11033b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103840>, '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': '74d6aec007b0fa31a864ebd7000001f8-1490829396.431613-2121658179', '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 16:17:25 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 16:17:25 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 16:17:25 INFO - Using env: {'DISPLAY': ':0', 16:17:25 INFO - 'HOME': '/home/cltbld', 16:17:25 INFO - 'LANG': 'en_US.UTF-8', 16:17:25 INFO - 'LANGUAGE': 'en_US:en', 16:17:25 INFO - 'LOGNAME': 'cltbld', 16:17:25 INFO - 'MAIL': '/var/mail/cltbld', 16:17:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:17:25 INFO - 'MOZ_NO_REMOTE': '1', 16:17:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:17:25 INFO - 'NO_EM_RESTART': '1', 16:17:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:17:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:17:25 INFO - 'PWD': '/builds/slave/test', 16:17:25 INFO - 'SHELL': '/bin/bash', 16:17:25 INFO - 'SHLVL': '1', 16:17:25 INFO - 'TERM': 'linux', 16:17:25 INFO - 'TMOUT': '86400', 16:17:25 INFO - 'USER': 'cltbld', 16:17:25 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1490829396.431613-2121658179', 16:17:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:17:25 INFO - '_': '/tools/buildbot/bin/python'} 16:17:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:17:26 INFO - Running setup.py (path:/tmp/pip-AakBaV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:17:26 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:17:26 INFO - Running setup.py (path:/tmp/pip-uyTq1w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:17:26 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)) 16:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:17:26 INFO - Running setup.py (path:/tmp/pip-q5atqS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:17:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:17:26 INFO - Running setup.py (path:/tmp/pip-GpPSyd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:17:26 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)) 16:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:17:26 INFO - Running setup.py (path:/tmp/pip-jSE269-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:17:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:17:26 INFO - Running setup.py (path:/tmp/pip-mqiA5c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:17:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:17:26 INFO - Running setup.py (path:/tmp/pip-wQ0Bvf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:17:26 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)) 16:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:17:26 INFO - Running setup.py (path:/tmp/pip-Nrp3JZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:17:26 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)) 16:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:17:26 INFO - Running setup.py (path:/tmp/pip-psVGNS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:17:26 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)) 16:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:17:26 INFO - Running setup.py (path:/tmp/pip-7uCKBm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:17:26 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)) 16:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:17:26 INFO - Running setup.py (path:/tmp/pip-M1hKOC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:17:26 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)) 16:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:17:27 INFO - Running setup.py (path:/tmp/pip-6q7CKn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:17:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:17:27 INFO - Running setup.py (path:/tmp/pip-7wFaB4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:17:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:17:27 INFO - Running setup.py (path:/tmp/pip-n_SiXG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:17:27 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)) 16:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:17:27 INFO - Running setup.py (path:/tmp/pip-_TF6XV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:17:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:17:27 INFO - Running setup.py (path:/tmp/pip-Sog9ff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:17:27 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)) 16:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:17:27 INFO - Running setup.py (path:/tmp/pip-fHXs0z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:17:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:17:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:17:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:17:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:17:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:17:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:17:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:17:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:17:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:17:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:17:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:17:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:17:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:17:29 INFO - Downloading blessings-1.6.tar.gz 16:17:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:17:29 INFO - Installing collected packages: blessings 16:17:29 INFO - Running setup.py install for blessings 16:17:29 INFO - Successfully installed blessings 16:17:29 INFO - Cleaning up... 16:17:29 INFO - Return code: 0 16:17:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:17:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:17:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:17:29 INFO - Reading from file tmpfile_stdout 16:17:29 INFO - Current package versions: 16:17:29 INFO - argparse == 1.2.1 16:17:29 INFO - blessings == 1.6 16:17:29 INFO - blobuploader == 1.2.4 16:17:29 INFO - docopt == 0.6.1 16:17:29 INFO - functools32 == 3.2.3-2 16:17:29 INFO - jsonschema == 2.5.1 16:17:29 INFO - manifestparser == 1.1 16:17:29 INFO - mozInstall == 1.12 16:17:29 INFO - mozcrash == 1.0 16:17:29 INFO - mozdebug == 0.1 16:17:29 INFO - mozdevice == 0.49 16:17:29 INFO - mozfile == 1.2 16:17:29 INFO - mozhttpd == 0.7 16:17:29 INFO - mozinfo == 0.9 16:17:29 INFO - mozleak == 0.1 16:17:29 INFO - mozlog == 3.4 16:17:29 INFO - moznetwork == 0.27 16:17:29 INFO - mozprocess == 0.25 16:17:29 INFO - mozprofile == 0.28 16:17:29 INFO - mozrunner == 6.13 16:17:29 INFO - mozscreenshot == 0.1 16:17:29 INFO - mozsystemmonitor == 0.3 16:17:29 INFO - moztest == 0.8 16:17:29 INFO - mozversion == 1.4 16:17:29 INFO - psutil == 3.1.1 16:17:29 INFO - requests == 1.2.3 16:17:29 INFO - wsgiref == 0.1.2 16:17:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:17:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:17:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:17:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:17:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:17:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:29 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 0xe671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1105310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102400>, '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 0x11033b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103840>, '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': '74d6aec007b0fa31a864ebd7000001f8-1490829396.431613-2121658179', '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 16:17:29 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 16:17:29 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 16:17:29 INFO - Using env: {'DISPLAY': ':0', 16:17:29 INFO - 'HOME': '/home/cltbld', 16:17:29 INFO - 'LANG': 'en_US.UTF-8', 16:17:29 INFO - 'LANGUAGE': 'en_US:en', 16:17:29 INFO - 'LOGNAME': 'cltbld', 16:17:29 INFO - 'MAIL': '/var/mail/cltbld', 16:17:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:17:29 INFO - 'MOZ_NO_REMOTE': '1', 16:17:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:17:29 INFO - 'NO_EM_RESTART': '1', 16:17:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:17:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:17:29 INFO - 'PWD': '/builds/slave/test', 16:17:29 INFO - 'SHELL': '/bin/bash', 16:17:29 INFO - 'SHLVL': '1', 16:17:29 INFO - 'TERM': 'linux', 16:17:29 INFO - 'TMOUT': '86400', 16:17:29 INFO - 'USER': 'cltbld', 16:17:29 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1490829396.431613-2121658179', 16:17:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:17:29 INFO - '_': '/tools/buildbot/bin/python'} 16:17:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:17:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:17:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:17:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:17:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:17:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:17:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:17:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:17:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:17:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:17:30 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:17:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:17:30 INFO - Cleaning up... 16:17:30 INFO - Return code: 0 16:17:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:17:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:17:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:17:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:17:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1105310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102400>, '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 0x11033b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103840>, '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': '74d6aec007b0fa31a864ebd7000001f8-1490829396.431613-2121658179', '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 16:17:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:17:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:17:30 INFO - Using env: {'DISPLAY': ':0', 16:17:30 INFO - 'HOME': '/home/cltbld', 16:17:30 INFO - 'LANG': 'en_US.UTF-8', 16:17:30 INFO - 'LANGUAGE': 'en_US:en', 16:17:30 INFO - 'LOGNAME': 'cltbld', 16:17:30 INFO - 'MAIL': '/var/mail/cltbld', 16:17:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:17:30 INFO - 'MOZ_NO_REMOTE': '1', 16:17:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:17:30 INFO - 'NO_EM_RESTART': '1', 16:17:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:17:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:17:30 INFO - 'PWD': '/builds/slave/test', 16:17:30 INFO - 'SHELL': '/bin/bash', 16:17:30 INFO - 'SHLVL': '1', 16:17:30 INFO - 'TERM': 'linux', 16:17:30 INFO - 'TMOUT': '86400', 16:17:30 INFO - 'USER': 'cltbld', 16:17:30 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1490829396.431613-2121658179', 16:17:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:17:30 INFO - '_': '/tools/buildbot/bin/python'} 16:17:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:17:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:17:30 INFO - Cleaning up... 16:17:30 INFO - Return code: 0 16:17:30 INFO - Running post-action listener: _resource_record_post_action 16:17:30 INFO - Running post-action listener: _start_resource_monitoring 16:17:30 INFO - Starting resource monitoring. 16:17:30 INFO - [mozharness: 2017-03-29 23:17:30.407072Z] Finished create-virtualenv step (success) 16:17:30 INFO - [mozharness: 2017-03-29 23:17:30.407533Z] Running install step. 16:17:30 INFO - Running pre-action listener: _resource_record_pre_action 16:17:30 INFO - Running main action method: install 16:17:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:17:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:17:30 INFO - Reading from file tmpfile_stdout 16:17:30 INFO - Detecting whether we're running mozinstall >=1.0... 16:17:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:17:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:17:30 INFO - Reading from file tmpfile_stdout 16:17:30 INFO - Output received: 16:17:30 INFO - Usage: mozinstall [options] installer 16:17:30 INFO - Options: 16:17:30 INFO - -h, --help show this help message and exit 16:17:30 INFO - -d DEST, --destination=DEST 16:17:30 INFO - Directory to install application into. [default: 16:17:30 INFO - "/builds/slave/test"] 16:17:30 INFO - --app=APP Application being installed. [default: firefox] 16:17:30 INFO - mkdir: /builds/slave/test/build/application 16:17:30 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'] 16:17:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:17:47 INFO - Reading from file tmpfile_stdout 16:17:47 INFO - Output received: 16:17:47 INFO - /builds/slave/test/build/application/firefox/firefox 16:17:47 INFO - Running post-action listener: _resource_record_post_action 16:17:47 INFO - [mozharness: 2017-03-29 23:17:47.607540Z] Finished install step (success) 16:17:47 INFO - [mozharness: 2017-03-29 23:17:47.607824Z] Running run-tests step. 16:17:47 INFO - Running pre-action listener: _resource_record_pre_action 16:17:47 INFO - Running main action method: run_tests 16:17:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:17:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:17:47 INFO - Python 2.7.3 16:17:47 INFO - Return code: 0 16:17:47 INFO - grabbing minidump binary from tooltool 16:17:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:17:47 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102400>, '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 0x11033b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:17:47 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:17:47 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:17:47 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 16:17:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:17:47 INFO - Return code: 0 16:17:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:17:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:17:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:17:47 INFO - ENV: RUST_BACKTRACE is now 1 16:17:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:17:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:17:47 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/frqLWP9oTZquTIy_-idEqg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 16:17:47 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/frqLWP9oTZquTIy_-idEqg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-042 --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 16:17:47 INFO - Using env: {'DISPLAY': ':0', 16:17:47 INFO - 'HOME': '/home/cltbld', 16:17:47 INFO - 'LANG': 'en_US.UTF-8', 16:17:47 INFO - 'LANGUAGE': 'en_US:en', 16:17:47 INFO - 'LOGNAME': 'cltbld', 16:17:47 INFO - 'MAIL': '/var/mail/cltbld', 16:17:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:17:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:17:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:17:47 INFO - 'MOZ_NO_REMOTE': '1', 16:17:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:17:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:17:47 INFO - 'NO_EM_RESTART': '1', 16:17:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:17:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:17:47 INFO - 'PWD': '/builds/slave/test', 16:17:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:17:47 INFO - 'RUST_BACKTRACE': '1', 16:17:47 INFO - 'SHELL': '/bin/bash', 16:17:47 INFO - 'SHLVL': '1', 16:17:47 INFO - 'TERM': 'linux', 16:17:47 INFO - 'TMOUT': '86400', 16:17:47 INFO - 'USER': 'cltbld', 16:17:47 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1490829396.431613-2121658179', 16:17:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:17:47 INFO - '_': '/tools/buildbot/bin/python'} 16:17:47 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/frqLWP9oTZquTIy_-idEqg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 16:17:47 INFO - mozversion application_buildid: 20170329222050 16:17:47 INFO - mozversion application_changeset: fc2eda92be4091d5ea0828f51fe4aaee41ed8319 16:17:47 INFO - mozversion application_display_name: Nightly 16:17:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:17:47 INFO - mozversion application_name: Firefox 16:17:47 INFO - mozversion application_remotingname: firefox 16:17:47 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:17:47 INFO - mozversion application_vendor: Mozilla 16:17:47 INFO - mozversion application_version: 55.0a1 16:17:47 INFO - mozversion platform_buildid: 20170329222050 16:17:47 INFO - mozversion platform_changeset: fc2eda92be4091d5ea0828f51fe4aaee41ed8319 16:17:47 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:17:47 INFO - mozversion platform_version: 55.0a1 16:17:47 INFO - using testdate: 1490829467 16:17:47 INFO - actual date: 1490829467 16:17:47 INFO - starting webserver on 'localhost:58174' 16:17:47 INFO - SUITE-START | Running 2 tests 16:17:47 INFO - TEST-START | dromaeo_css 16:17:47 INFO - operating with platform_type : linux_ 16:17:47 INFO - Initialising browser for dromaeo_css test... 16:17:47 INFO - TEST-INFO | started process 13328 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiuJlh3/profile http://localhost:58174/getInfo.html) 16:17:51 INFO - PID 13328 | __metrics Screen width/height:1600/1200 16:17:51 INFO - PID 13328 | colorDepth:24 16:17:51 INFO - PID 13328 | Browser inner width/height: 1024/697 16:17:51 INFO - PID 13328 | __metrics 16:17:53 ERROR - PID 13328 | 1490829473163 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) 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:96:5 < callBootstrapMethod@XPIProvider.jsm:4957:11 < observe@XPIProvider.jsm:2924: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 16:17:53 INFO - PID 13328 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:17:53 INFO - PID 13328 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:17:54 INFO - TEST-INFO | 13328: exit 0 16:17:54 INFO - Browser initialized. 16:17:54 INFO - Running cycle 1/1 for dromaeo_css test... 16:17:54 INFO - TEST-INFO | started process 13421 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiuJlh3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:18:06 INFO - PID 13421 | RSS: Main: 144621568 16:18:06 INFO - PID 13421 | 16:21:08 INFO - PID 13421 | Cycle 1(1): loaded http://localhost:58174/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58174/tests/dromaeo/cssquery-ext.html) 16:21:10 INFO - PID 13421 | RSS: Main: 294879232 16:21:10 INFO - PID 13421 | 16:22:55 INFO - PID 13421 | ************************* 16:22:55 INFO - PID 13421 | A coding exception was thrown and uncaught in a Task. 16:22:55 INFO - PID 13421 | 16:22:55 ERROR - PID 13421 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:22:55 INFO - PID 13421 | Full stack: 16:22:55 INFO - PID 13421 | ************************* 16:22:55 INFO - PID 13421 | ************************* 16:22:55 INFO - PID 13421 | A coding exception was thrown and uncaught in a Task. 16:22:55 INFO - PID 13421 | 16:22:55 ERROR - PID 13421 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:22:55 INFO - PID 13421 | Full stack: 16:22:55 INFO - PID 13421 | ************************* 16:22:55 INFO - PID 13421 | ************************* 16:22:55 INFO - PID 13421 | A coding exception was thrown and uncaught in a Task. 16:22:55 INFO - PID 13421 | 16:22:55 ERROR - PID 13421 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:22:55 INFO - PID 13421 | Full stack: 16:22:55 INFO - PID 13421 | ************************* 16:22:55 INFO - PID 13421 | ************************* 16:22:55 INFO - PID 13421 | A coding exception was thrown and uncaught in a Task. 16:22:55 INFO - PID 13421 | 16:22:55 ERROR - PID 13421 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:22:55 INFO - PID 13421 | Full stack: 16:22:55 INFO - PID 13421 | ************************* 16:24:12 INFO - PID 13421 | Cycle 1(1): loaded http://localhost:58174/tests/dromaeo/cssquery-ext.html (next: http://localhost:58174/tests/dromaeo/cssquery-jquery.html) 16:24:13 INFO - PID 13421 | RSS: Main: 230645760 16:24:13 INFO - PID 13421 | 16:27:14 INFO - PID 13421 | Cycle 1(1): loaded http://localhost:58174/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58174/tests/dromaeo/cssquery-mootools.html) 16:27:15 INFO - PID 13421 | RSS: Main: 213213184 16:27:15 INFO - PID 13421 | 16:30:17 INFO - PID 13421 | Cycle 1(1): loaded http://localhost:58174/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58174/tests/dromaeo/cssquery-prototype.html) 16:30:18 INFO - PID 13421 | RSS: Main: 178298880 16:30:18 INFO - PID 13421 | 16:33:20 INFO - PID 13421 | Cycle 1(1): loaded http://localhost:58174/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58174/tests/dromaeo/cssquery-yui.html) 16:33:21 INFO - PID 13421 | RSS: Main: 188293120 16:33:21 INFO - PID 13421 | 16:36:24 INFO - PID 13421 | Cycle 1(1): loaded http://localhost:58174/tests/dromaeo/cssquery-yui.html (next: http://localhost:58174/tests/dromaeo/cssquery-dojo.html) 16:36:24 INFO - PID 13421 | RSS: Main: 278904832 16:36:24 INFO - PID 13421 | 16:36:24 INFO - PID 13421 | __start_tp_report 16:36:24 INFO - PID 13421 | _x_x_mozilla_page_load 16:36:24 INFO - PID 13421 | _x_x_mozilla_page_load_details 16:36:24 INFO - PID 13421 | |i|pagename|runs| 16:36:24 INFO - PID 13421 | |0;dojo.html;3213.244887451449;3260.967390326096;3289.967100328996;3292.5555050068233;3292.5555050068233;5662.122371032487;5750.942490575104;5899.351071382155;5915.053591425372;5921.822345329641;5844.970775146118;5870.970645146768;5894.2042824218715;5939.821805345847;5982.820515384546;5108.770105345268;5144.897102057976;5203.323567936182;5229.267902493663;5283.8111424929275;5220.425753167167;5263.736813159346;5286.524212820846;5290.391604965421;5292.311999440087;5052.292679024939;5091.898162036776;5124.180131179012;5144.588432925357;5148.742562871841;5118.948810511884;5128.435872054071;5147.794088236466;5149.124648809711;5153.484651534854;5078.085944529983;5109.642325037249;5114.7698353573805;5121.308623335839;5123.897522049539;5675.262215911905;5679.971600142014;5680.261565996435;5685.374608793029;5691.6585004899425;6050.6369617823075;6100.572959892809;6105.664188469633;6110.266767987825;6118.9694051529905;6315.431611155018;6338.556301058928;6363.554551181419;6384.585001974857;6434.420902118832;5903.49820265278;5924.82225533226;5925.762969481216;5930.762769489215;5983.640981541122;6151.9692401538605;6452.290248072708;6491.610503369719;6504.284528701839;6504.447121994589;5996.580239383288;6095.529019716752;6194.876102478015;6194.907076393858;6219.502439804804;6330.525210609223;6336.461400780893;6340.587861789061;6350.714217860207;6351.396617321347;6286.748530058838;6317.9684101580115;6319.431251187415;6330.01884707871;6337.714802833883;6046.123312119718;6105.8168254952425;6117.908231376533;6191.628502289787;6243.875122497616;4778.283257511401;4800.3759511263315;4800.975995120002;4801.51984801517;4838.903221935612;4207.326827707552;4213.241616508996;4238.385434112037;4252.043290259667;4266;5666.801661941812;5687.289088863892;5862.237909071793;5913.704314784243;5930.525557955353;6303.432691057827;6351.333110023474;6354.936450635527;6357.554971151975;6364.331745166691;5847;5909.3795151508475;5915.70421478933;5919.852003699942;5974.551908606872;5126.359205099363;5239.397469291081;5321.281626980385;5345.358556973188;5350.3312085989255;6449;6559.639219842859;6562.8359291018105;6564.770233041821;6572.375624315682;6303.527235457267;6344.619322840645;6348.238211414659;6352.968235158794;6353.745850166127;6195.783147589813;6293.213348331458;6293.937060629335;6294.968525157528;6465.77369792055;6203.8138855834395;6221.688915554114;6227.595206311576;6235.657038862906;6248.4064013918605;6338.683065846782;6340.365963403623;6340.4293613575;6345.079963405188;6360.427561519486;5909.261342332208;5916.171735957056;6160.784372546939;6167.074938759222;6167.907481387693;6131.284916201153;6136.171616831849;6171.290301615371;6176.073588961692;6181.752729890754;6118.60229085108;6139.293981192041;6148.661823599745;6163.414475624809;6166.599171053867;5912.674802885883;6113.786017489367;6197.163382943245;6217.937820621736;6232.501399888089;5838.1826544282985;5843.035899076604;5843.035899076604;5845.210896528914;5857.560682948882 16:36:24 INFO - PID 13421 | |1;ext.html;706.4630880530798;763.8128658478672;789.518393779794;1124.3478782306263;1131.6209069961562;30957.690423095763;31140.68859311406;31166.376672466566;31171.99999999997;38278.617213827856;41768.58231417685;42065.57934420655;42077.7896110519;42119.36820947681;42216.99999999992;8237.052738935025;8394.706185283516;8404.1175676554;8406.075331713506;8407.24334809867;6174.4134307240965;6320.652364119972;8109.472884262534;8297.668093276261;8307.875381869246;8417.284530814888;8463.703770368038;8468.322534197281;8476.067632560413;8476.830463390728;8367.330613550901;8431.662733490653;8439.915600844035;8451.323894088458;8454.61954212062;8286.254237118688;8319.66721331146;8352.540610266433;8362.16378362165;8371.623276952552;39268.80365598154;39287;39334.21331573353;39433.60566394357;39552;2962.081754656042;2965.1697524693122;2973.3607274435885;2980.3592227671156;3007.443622929765;28310.43887924622;28331.57502637462;28368;28755.56866646981;28877.278068048257;3569.7501174917766;3623.547056617923;3658.1951970566433;3683.7421380503374;3697.8151092445537;215018;215033;215120;216265;216932;48784.26823597649;48869.755651221516;48893.511064888895;48904.7554762231;49041.754791225816;51953.220701689504;51976;52058;52077.7396113017;52135;13955.860441395456;14300.785488217685;14320.283985800668;14339.139651620937;14364.138151710931;11316.207865449504;11387;11394.886051139383;11395.487203075882;11415.143864210051;11656.358900260568;11940.402979850973;12988.415521301564;13093.607191784262;13376.866231337563;5117.718525481134;5268.341457317835;5278.81524146653;5284.5772338212855;5314.97342513285;1024.994875025635;1041.6250149946013;1059.6105781462907;1062.7024433158729;1082.8375743638517;25667.614985775228;25730.228093157235;25741.3564660885;26008.21975340705;26017.219483415527;1137.221003612528;1153.6654370232538;1155.942202889852;1162.4826952006445;1182.0872910665723;13095.607131786062;13371.06402551812;13378.331083445983;13500.257485838176;13502.797458038138;293185;294280;294335;294969;295154;54415.72792136014;54480.18279725807;54525.45474545283;54564.18153727697;54604.45395546073;1389.666480044782;1461.228148812196;1477.7044591081826;1495.4691084665005;1510.8035955325738;23328.766712333338;24060.674224403258;24434.877825610758;24474.51050979006;24627.630585540872;39592.208155837296;39865.2026959465;39868.60131398649;39905.800470997456;39937.201255974134;302779;304798;305746;306097;307631;33748.325033499685;34313.48529772006;34415.65584344225;34440.82779586086;34465.31069378548;40552.797236013634;40960.38559421551;41090;41225.587744122175;41898;31443.685563144074;31562.842185788923;31582.36835263328;32133.517997229592;33324.333513330086;31871;31909.840450797597;32248.83875580607;33103.66896331006;33223.66776332206;37182.25635487221;37431.25137497289;37597.81201093977;38198.80900595479;38296;29699.703002969694;30628.84685576558;30838.845805770827;30984.845075774476;31646.683533165295;25219.369515762253;25278.74721252764;25450.872745636152;25494.362640934127;25701.742982569936 16:36:24 INFO - PID 13421 | |2;jquery.html;371.90516418313325;430.4920194170877;449.28339298818395;463.33974086926133;465.20450030447955;15564.533064008097;19553.804461955377;20112.59774804505;20934.685979710277;21363.252286169987;16072.116033618146;17581.472555823315;21992.45018874529;22050.558988820216;22294.777052229474;5764.250647415841;6002.759889604411;6008.909866352008;6009.1587177795145;6011.398860113997;5700.914486282688;5781.277340332458;5802.419758024185;5811.593188476808;5888.411158884121;5764.279465066867;5778.913316300259;5799.73901174446;5805.071188609823;5811.970940145294;5739.741711622987;5763.1067184586245;5793.681347525863;5914.2015827863115;5919.585629005971;5139.306193663845;5353.785848566053;5370.113931201347;5382.973085134549;5383.650062745909;24230.7576924232;24493.87753061241;24534.754652453605;24728.13451529206;24744.13395531166;1969.8227159555709;1973.2850621127272;1992.2031187525106;2009.7789243183238;2030.0255877179036;15360;15902.204889755465;16032.75950860738;16103.516894493185;16658.0838053907;1876.8780029298189;1923.85571082168;1950.8146726061002;1963.6465436221474;1971.8126777956215;94847;96269;98047;99717;100401;11020.173486988508;12133.393330333625;12185.878141218474;12207.938960305319;12232.266064036186;16322.75515867263;16814.915925420293;17447.73828392575;17535;17542.561435964202;8592.44149130317;8630.136986301319;8845.203931646054;8919.554022298858;8959.372843900865;7985.760427187193;8046.356291496666;8072.240522667339;8312.8753068704;8351.540665263468;7304.926950730424;7489.28851759082;7573.810654733566;7574.166841647414;7691.1155217150745;2165.43698638352;2167.7318768520277;2185.748638906546;2196.5716685246225;2236.4632488203038;1003.4280460137652;1025.7128004158847;1038.8078205532001;1043.4209013997304;1045.9320144190756;18974.620507590047;19699.507512312306;19753.901230494044;19909.701354479694;20025.599488010448;1033.4677641014882;1038.08129805123;1043.2749239278628;1052.3054783842626;1065.9040686338267;9887.950560247296;10844.349339039525;11884.881151188378;13055.21668699881;13237.139585926883;629143;631366;632101;632200;643551;106827.46586267019;107086.46456767822;110117.44941275242;111028.44485777519;112536;1177.6996865799167;1204.7891618966646;1212.799888018467;1246.4453318273281;1248.3196657821509;18929.716054258923;19098.23607055702;19479.415617531497;19708.901455493204;19745.308914187935;50863.74568127136;51111.32091410129;51804;51940.74029629979;52706;64810;66184;66969.75135092092;67770.3222967764;69262;8850.95574522149;8866.246369058703;8872.423292485968;9096.363254572381;9369.203617692572;13331.933340333237;13388;13545.577714340247;13844.861551384358;13941.163530188222;11556.94221528887;11637.127215458706;11719.88280117188;11934.104942129201;11981.221220620631;11092.168087393316;11152.49813758399;11269.154813388865;11407.144464165387;11425.428728563706;11983.400829958642;12167.148299618942;12223.327716975651;12328.260304381407;12443.315617641116;8898.822023559364;8947.150020748279;8965.282777377925;9125.908740912771;9474.052594740471;11770.411479426166;11962.342071186169;12143.75712485763;12158.696032599255;12269.325187114795 16:36:24 INFO - PID 13421 | |3;mootools.html;1308.3915979069734;1369.5412036967616;1383.2668685596632;1391.0401822742313;1392.380390726127;10663.680089597305;11118.722031949206;11124.666260012193;11144.777104457906;11144.832827507584;10942.124630029599;11082.445877706123;11392.430378481064;11457;11465.312081275108;2355.2110043135526;2395.646459750244;2398.70016247969;2400.579898517761;2403.0507949359994;1985.6128055029276;2225.9109635614554;2316.7683231676783;2352.717673879128;2359.7876191142796;2033.1968872295433;2268.6937263469385;2354.2584086012935;2357.363511851799;2360.24472168906;2223.8665680059084;2307.2501437032947;2311.3181611424584;2316.9884150579223;2321.2455951815728;2272.8295377846725;2280.0879648140876;2281.9543609127722;2284.1662793080404;2301.6432452969816;11133;11230.606928757454;11233.438328083563;11237.26957747752;11243.943780281046;5896.616719913192;6112.694365281763;6119.5104391648565;6123.081537769326;6126.417990290915;3539.07983924179;3559.875404360861;3725.795081270529;3730.1607138393915;3753.5871054184017;1282.33959510852;1340.9530666426629;1348.7369962857247;1395.2674845705983;1403.0669604712855;16374.263158157792;16509.257083431155;16553.172341382884;16568.75146872786;16571.751423728652;5245.501677340647;5370.865728356823;5465.535429488458;5729.713514324267;5756.194132821408;12598.81101783474;12715.682107947376;12728.80906786399;12731.23612583248;12735.745285094246;6229.844253893598;6239.188905442355;6243.157173781481;6248.843778905563;6253.96873015632;5676.318841738936;5776.393478684761;5809.796657116981;5813.069908814569;5829.329627092939;4104.52797928242;4242.53332133465;4291.635211007099;4368.737875727466;4454.042380888124;1053.6259627832162;1231.9322437265857;1275.069199484363;1283.9471633260637;1287.549357724789;735.5880706804206;840.2521755637488;845.9703910363107;866.7226487524058;887.1128871128872;6022.638641681513;6132.50939924805;6200.658963756947;6271.247450305901;6401.775937842246;919.5034681272172;927.9443233406017;946.0964778636386;954.2270760683869;964.3827950111934;4252.617264446215;4449.555044495524;4481.2381895077915;4516.277395616686;4520.728756274634;14199.148051116967;14680.192589407472;14746.18895960711;14754.262286885612;14773.778393324108;13954.162750235018;14501.637459063608;14543.127412355292;14562;14572.85427145715;10275.434851083113;10427.68716938493;10539.473026348805;10549.47252637365;10614.203934704929;6531.281559028408;7092.680829362588;7197.064381630355;7217.963910180415;7293.4894557382595;12953.287569183785;12998.545050923172;13076.476940922257;13356.198628082346;13374.465021399035;13311.933440332736;13407.195568265935;13434.193948363129;13548.051636385359;13651.453941842215;9386.108319709616;9441.10309520622;9512.762180945532;9599.520023998912;9601.039896010623;10295.12491438236;10360.585576577154;10515.421651809223;10527;10531.578736850746;6900.137482814648;8282.088970213392;8680.088590697886;8751.256143227896;8935;8229.83540329202;8401.915980840113;8546.35902307317;8666.220040196413;8707.738767836974;7272.636368181464;7282.708691652275;7305.817354566178;7416.851662966818;7462.44031697614;5941.643501389757;5969.557437907958;5981.102834574848;6046.94629212245;6072.210612620508;5990.191324171181;6109.7861574844665;6111.480524155497;6188.4739797117745;6290.109146626742 16:36:24 INFO - PID 13421 | |4;prototype.html;416.1365167277898;418.9651560645206;419.19096144441255;425.24230366075994;429.14814094023376;5889.146073819294;5980.342162362137;5992.5505587080925;6007.5494337924665;6016.338202797689;5876.412358764122;5878.794242201524;5901.793437229687;5909.8227053188475;5927.2887253529525;4395.494518130424;4532.161550113223;4545.431821022372;4560.179167749804;4643.628509719223;4498.122866041123;4543.522930092342;4550.497226525398;4553.658475614326;4555.954440455603;4501.594856462918;4537.75042372671;4538.387317712116;4543.886402839922;4554.43069616298;4412.8455504057365;4506.098780243931;4526.456825180966;4528.8867778305475;4542.727436353813;3959.1883663848844;3969.186316805077;3979.283728928792;3984.322665146903;3985.980070099631;5673.971630141864;5692.37383887772;5727.427257274281;5730.856728581777;5752.7986520472;5138.691942184762;5263.499967503081;5283.445238249967;5293.258943747878;5318.867028324285;6199.101130336121;6212.254529456494;6216.440520353145;6226.252849658024;6249.500039996789;4428.40216570762;4448.4439445069365;4467.82128714851;4470.8435204768;4479;6206.627602343829;6295.213098362705;6354.586951848161;6526.869462610721;6561.179852518435;4763.904721905543;4808.2787581863;4812.326274321597;4856.854294371175;4873.488283730228;4911.484294149134;4925.162722337212;4945.802167913315;4951.826686066042;4952.950470495249;5274.839535302227;5378.865528361822;5467.261919640877;5478.164814787091;5487.368952570426;6237.656928868956;6252.874942501216;6270.99328214976;6287.591306565058;6295.118683384329;1680.4118558504426;1689.8901571398067;1693.9407120750714;1697.2786565709523;1700.498352985872;1189.411241435495;1210.7396909664287;1213.3508572913624;1216.416120262279;1237.9071569632133;5892.558058145656;5898.4101589840675;5926.881462370815;5938.8218353449465;5945;6139.508839292846;6345.936540634534;6365.649889256136;6374.171357723466;6387.936120638827;5863.765449381977;5874.236349274567;5892.469677728939;5897.115432685132;5915.1718759373725;3338.2989572190113;3341;3354.111160542458;3365.730741540671;3374.4263475209273;6347.809565713036;6515.771947981798;6553.148090748172;6593.274739778621;6619.172603424572;6518.217813862367;6544.869102617921;6551.672416379257;6555.246146693191;6559.934400656028;6293.874122517615;6493.740250390026;6566.770163044366;6605.801825945229;6629.436497897733;6401.583897046677;6403.4877209824035;6407.10300557913;6428.517861160338;6460.289368169591;6218.253809542703;6360.681965901594;6399.904001440075;6415.711292991733;6419.688911991772;6656.301088385843;6667.19993600771;6672.131803094947;6686.5653732507235;6703.765368212285;4530.841420550397;4540.228161212536;4564.931526027046;4572.6799124061;4579;6343.111964324906;6354.459870911024;6404.775832845828;6419.550631455753;6468.708908099241;6251.6558939828155;6261.123442718114;6263.74945002213;6270.905936410866;6274.184356033869;6014.9097763534455;6212.502999760099;6234.251889773256;6268.811935641938;6276.117164850435;6231.937680623136;6234.3453937337745;6246.937530624818;6250.406211409909;6256.843578910563;6101.7559297627595;6272.435480806749;6276.780312689034;6297.118403423616;6314.989601663712;6078.422549857756;6086.60437071589;6089.634621922699;6113.174721412553;6115.480184184395 16:36:24 INFO - PID 13421 | |5;yui.html;766.5630590563378;769.3153093746563;771.9691212351506;779.8557266905623;797.4378063465253;16260.75608865868;17028.148592570386;17038.48884533463;17055.488335349928;17116.486505404842;15689.607759806011;15774.605634859134;15988.200589970513;15993.120378379184;15993.600159996005;928.9071092890707;930.9720708378726;967.3132076225888;974.585801034561;979.2900147393154;974.926880483963;975.0931633580767;976.053228368485;976.3995142987083;976.4434272464698;1024.3188279793928;1025.6307729217476;1028.686250693538;1029.8146333659938;1029.97002997003;1015.3806178231273;1020.3010937507831;1021.5709402051119;1021.780317231795;1022.3763504262394;741.1883987034189;746.9327760501527;747.1221314954961;747.3348719639525;747.4618274842105;16176.514704558764;16310.429134980337;16587.419440319532;16670.833291667048;16684;16129.435469758502;16259.593510162222;16260.674786504203;16269.674606507804;16411.58971025722;11700.414979251003;11858.940705296418;12081.637550873487;12541.811872821914;12690.809637855347;3126.265327648001;3156.526521021842;3271.4275001874817;3283.688049635281;3285.6221534523356;84151.57924210401;87483.56258218733;87679.12320876773;88585.55707221487;88803;11760.764784704257;11769.705757355963;11847.763044739057;11971.46128424223;12548.81176782349;24163.275101746625;24229;24545.440911067795;24553.631695524582;24554.140605078737;8131.390145739093;8178;8240.13478584752;8364.665413383396;8407.369447291478;4017.738846974937;4043.8786836394956;4058.1477889642915;4071.246819338432;4093.89765255871;4262.850800221977;4294.484661840599;4295.892602684896;4325.048489332342;4362.716423432466;730.8830587106144;733.8825787873915;754.4190972950797;763.7861398808343;773.161120184606;636.6689321552859;643.530222937249;653.2491982626107;662.2185820731487;663.2339647706906;10300.639477618248;10710.581041576623;10731.980461856112;10834.295770774874;10879.456027198608;669.1735706402588;670.1589505170979;671.9798406047827;672.9629870357178;673.4511373230802;4476.776161191928;4831.5651591356245;4847.127517046965;4848.254818040633;4876.792902162153;77795.22204777993;77933.27233546799;79880.60059699665;82283.5885820567;85942.57028714816;69432;73125;73223.63388183025;75350.62324688342;76854;62305.688471557354;62965;63533.36466635275;63897.680511598075;63959.3604063972;9703.563339649592;9710.320277580502;9837.557309920927;9869.753256168366;9873.160781333667;30661.386772264876;31182.68817311798;32791.50812737763;32818.67181328156;33926.15184620306;46297.76851115723;47065;47893.16854651689;48076.75961620169;49979.25031124609;14002.859971400563;14022.789658154932;14268.785968210277;14488.203148826915;15058.536536596424;15298.93350219174;15679;16063.188941935348;16159.27283272279;16592.419265325654;15186.46847360337;15262;15307;15591.14248716286;15609.68780624404;13216.207027578375;13772.24252666113;13796.793048104086;13800.378982945993;13839.792403113759;13724.794128088286;14330.57008289753;14600.634984125481;14752.483663071742;14762;9848.680165797434;10210.897891020995;10227.488625568543;10236.53935572886;10249.12882405004;9876;10888.18338624622;10909.490377797669;12193;12718.236905785683 16:36:24 INFO - PID 13421 | __end_tp_report 16:36:24 INFO - PID 13421 | __start_cc_report 16:36:24 INFO - PID 13421 | _x_x_mozilla_cycle_collect,1556 16:36:24 INFO - PID 13421 | __end_cc_report 16:36:24 INFO - PID 13421 | __startTimestamp1490830584805__endTimestamp 16:36:24 INFO - PID 13421 | 16:36:24 INFO - PID 13421 | ------- Summary: start ------- 16:36:24 INFO - PID 13421 | Number of tests: 6 16:36:24 INFO - PID 13421 | 16:36:24 INFO - PID 13421 | [#0] dojo.html Cycles:165 Average:5781.15 Median:5983.64 stddev:703.11 (11.8%) stddev-sans-first:675.79 16:36:24 INFO - PID 13421 | Values: 3213.2 3261.0 3290.0 3292.6 3292.6 5662.1 5750.9 5899.4 5915.1 5921.8 5845.0 5871.0 5894.2 5939.8 5982.8 5108.8 5144.9 5203.3 5229.3 5283.8 5220.4 5263.7 5286.5 5290.4 5292.3 5052.3 5091.9 5124.2 5144.6 5148.7 5118.9 5128.4 5147.8 5149.1 5153.5 5078.1 5109.6 5114.8 5121.3 5123.9 5675.3 5680.0 5680.3 5685.4 5691.7 6050.6 6100.6 6105.7 6110.3 6119.0 6315.4 6338.6 6363.6 6384.6 6434.4 5903.5 5924.8 5925.8 5930.8 5983.6 6152.0 6452.3 6491.6 6504.3 6504.4 5996.6 6095.5 6194.9 6194.9 6219.5 6330.5 6336.5 6340.6 6350.7 6351.4 6286.7 6318.0 6319.4 6330.0 6337.7 6046.1 6105.8 6117.9 6191.6 6243.9 4778.3 4800.4 4801.0 4801.5 4838.9 4207.3 4213.2 4238.4 4252.0 4266.0 5666.8 5687.3 5862.2 5913.7 5930.5 6303.4 6351.3 6354.9 6357.6 6364.3 5847.0 5909.4 5915.7 5919.9 5974.6 5126.4 5239.4 5321.3 5345.4 5350.3 6449.0 6559.6 6562.8 6564.8 6572.4 6303.5 6344.6 6348.2 6353.0 6353.7 6195.8 6293.2 6293.9 6295.0 6465.8 6203.8 6221.7 6227.6 6235.7 6248.4 6338.7 6340.4 6340.4 6345.1 6360.4 5909.3 5916.2 6160.8 6167.1 6167.9 6131.3 6136.2 6171.3 6176.1 6181.8 6118.6 6139.3 6148.7 6163.4 6166.6 5912.7 6113.8 6197.2 6217.9 6232.5 5838.2 5843.0 5843.0 5845.2 5857.6 16:36:24 INFO - PID 13421 | 16:36:24 INFO - PID 13421 | [#1] ext.html Cycles:180 Average:42950.69 Median:32021.68 stddev:71922.17 (224.6%) stddev-sans-first:72053.99 16:36:24 INFO - PID 13421 | Values: 706.5 763.8 789.5 1124.3 1131.6 30957.7 31140.7 31166.4 31172.0 38278.6 41768.6 42065.6 42077.8 42119.4 42217.0 8237.1 8394.7 8404.1 8406.1 8407.2 6174.4 6320.7 8109.5 8297.7 8307.9 8417.3 8463.7 8468.3 8476.1 8476.8 8367.3 8431.7 8439.9 8451.3 8454.6 8286.3 8319.7 8352.5 8362.2 8371.6 39268.8 39287.0 39334.2 39433.6 39552.0 2962.1 2965.2 2973.4 2980.4 3007.4 28310.4 28331.6 28368.0 28755.6 28877.3 3569.8 3623.5 3658.2 3683.7 3697.8 215018.0 215033.0 215120.0 216265.0 216932.0 48784.3 48869.8 48893.5 48904.8 49041.8 51953.2 51976.0 52058.0 52077.7 52135.0 13955.9 14300.8 14320.3 14339.1 14364.1 11316.2 11387.0 11394.9 11395.5 11415.1 11656.4 11940.4 12988.4 13093.6 13376.9 5117.7 5268.3 5278.8 5284.6 5315.0 1025.0 1041.6 1059.6 1062.7 1082.8 25667.6 25730.2 25741.4 26008.2 26017.2 1137.2 1153.7 1155.9 1162.5 1182.1 13095.6 13371.1 13378.3 13500.3 13502.8 293185.0 294280.0 294335.0 294969.0 295154.0 54415.7 54480.2 54525.5 54564.2 54604.5 1389.7 1461.2 1477.7 1495.5 1510.8 23328.8 24060.7 24434.9 24474.5 24627.6 39592.2 39865.2 39868.6 39905.8 39937.2 302779.0 304798.0 305746.0 306097.0 307631.0 33748.3 34313.5 34415.7 34440.8 34465.3 40552.8 40960.4 41090.0 41225.6 41898.0 31443.7 31562.8 31582.4 32133.5 33324.3 31871.0 31909.8 32248.8 33103.7 33223.7 37182.3 37431.3 37597.8 38198.8 38296.0 29699.7 30628.8 30838.8 30984.8 31646.7 25219.4 25278.7 25450.9 25494.4 25701.7 16:36:24 INFO - PID 13421 | 16:36:24 INFO - PID 13421 | [#2] jquery.html Cycles:180 Average:35049.52 Median:21148.97 stddev:104422.67 (493.7%) stddev-sans-first:104683.13 16:36:24 INFO - PID 13421 | Values: 371.9 430.5 449.3 463.3 465.2 15564.5 19553.8 20112.6 20934.7 21363.3 16072.1 17581.5 21992.5 22050.6 22294.8 5764.3 6002.8 6008.9 6009.2 6011.4 5700.9 5781.3 5802.4 5811.6 5888.4 5764.3 5778.9 5799.7 5805.1 5812.0 5739.7 5763.1 5793.7 5914.2 5919.6 5139.3 5353.8 5370.1 5383.0 5383.7 24230.8 24493.9 24534.8 24728.1 24744.1 1969.8 1973.3 1992.2 2009.8 2030.0 15360.0 15902.2 16032.8 16103.5 16658.1 1876.9 1923.9 1950.8 1963.6 1971.8 94847.0 96269.0 98047.0 99717.0 100401.0 11020.2 12133.4 12185.9 12207.9 12232.3 16322.8 16814.9 17447.7 17535.0 17542.6 8592.4 8630.1 8845.2 8919.6 8959.4 7985.8 8046.4 8072.2 8312.9 8351.5 7304.9 7489.3 7573.8 7574.2 7691.1 2165.4 2167.7 2185.7 2196.6 2236.5 1003.4 1025.7 1038.8 1043.4 1045.9 18974.6 19699.5 19753.9 19909.7 20025.6 1033.5 1038.1 1043.3 1052.3 1065.9 9888.0 10844.3 11884.9 13055.2 13237.1 629143.0 631366.0 632101.0 632200.0 643551.0 106827.5 107086.5 110117.4 111028.4 112536.0 1177.7 1204.8 1212.8 1246.4 1248.3 18929.7 19098.2 19479.4 19708.9 19745.3 50863.7 51111.3 51804.0 51940.7 52706.0 64810.0 66184.0 66969.8 67770.3 69262.0 8851.0 8866.2 8872.4 9096.4 9369.2 13331.9 13388.0 13545.6 13844.9 13941.2 11556.9 11637.1 11719.9 11934.1 11981.2 11092.2 11152.5 11269.2 11407.1 11425.4 11983.4 12167.1 12223.3 12328.3 12443.3 8898.8 8947.2 8965.3 9125.9 9474.1 11770.4 11962.3 12143.8 12158.7 12269.3 16:36:24 INFO - PID 13421 | 16:36:24 INFO - PID 13421 | [#3] mootools.html Cycles:180 Average:6990.79 Median:2377.95 stddev:4480.22 (188.4%) stddev-sans-first:4472.44 16:36:24 INFO - PID 13421 | Values: 1308.4 1369.5 1383.3 1391.0 1392.4 10663.7 11118.7 11124.7 11144.8 11144.8 10942.1 11082.4 11392.4 11457.0 11465.3 2355.2 2395.6 2398.7 2400.6 2403.1 1985.6 2225.9 2316.8 2352.7 2359.8 2033.2 2268.7 2354.3 2357.4 2360.2 2223.9 2307.3 2311.3 2317.0 2321.2 2272.8 2280.1 2282.0 2284.2 2301.6 11133.0 11230.6 11233.4 11237.3 11243.9 5896.6 6112.7 6119.5 6123.1 6126.4 3539.1 3559.9 3725.8 3730.2 3753.6 1282.3 1341.0 1348.7 1395.3 1403.1 16374.3 16509.3 16553.2 16568.8 16571.8 5245.5 5370.9 5465.5 5729.7 5756.2 12598.8 12715.7 12728.8 12731.2 12735.7 6229.8 6239.2 6243.2 6248.8 6254.0 5676.3 5776.4 5809.8 5813.1 5829.3 4104.5 4242.5 4291.6 4368.7 4454.0 1053.6 1231.9 1275.1 1283.9 1287.5 735.6 840.3 846.0 866.7 887.1 6022.6 6132.5 6200.7 6271.2 6401.8 919.5 927.9 946.1 954.2 964.4 4252.6 4449.6 4481.2 4516.3 4520.7 14199.1 14680.2 14746.2 14754.3 14773.8 13954.2 14501.6 14543.1 14562.0 14572.9 10275.4 10427.7 10539.5 10549.5 10614.2 6531.3 7092.7 7197.1 7218.0 7293.5 12953.3 12998.5 13076.5 13356.2 13374.5 13311.9 13407.2 13434.2 13548.1 13651.5 9386.1 9441.1 9512.8 9599.5 9601.0 10295.1 10360.6 10515.4 10527.0 10531.6 6900.1 8282.1 8680.1 8751.3 8935.0 8229.8 8401.9 8546.4 8666.2 8707.7 7272.6 7282.7 7305.8 7416.9 7462.4 5941.6 5969.6 5981.1 6046.9 6072.2 5990.2 6109.8 6111.5 6188.5 6290.1 16:36:24 INFO - PID 13421 | 16:36:24 INFO - PID 13421 | [#4] prototype.html Cycles:180 Average:5259.30 Median:5912.50 stddev:1523.07 (25.8%) stddev-sans-first:1483.33 16:36:24 INFO - PID 13421 | Values: 416.1 419.0 419.2 425.2 429.1 5889.1 5980.3 5992.6 6007.5 6016.3 5876.4 5878.8 5901.8 5909.8 5927.3 4395.5 4532.2 4545.4 4560.2 4643.6 4498.1 4543.5 4550.5 4553.7 4556.0 4501.6 4537.8 4538.4 4543.9 4554.4 4412.8 4506.1 4526.5 4528.9 4542.7 3959.2 3969.2 3979.3 3984.3 3986.0 5674.0 5692.4 5727.4 5730.9 5752.8 5138.7 5263.5 5283.4 5293.3 5318.9 6199.1 6212.3 6216.4 6226.3 6249.5 4428.4 4448.4 4467.8 4470.8 4479.0 6206.6 6295.2 6354.6 6526.9 6561.2 4763.9 4808.3 4812.3 4856.9 4873.5 4911.5 4925.2 4945.8 4951.8 4953.0 5274.8 5378.9 5467.3 5478.2 5487.4 6237.7 6252.9 6271.0 6287.6 6295.1 1680.4 1689.9 1693.9 1697.3 1700.5 1189.4 1210.7 1213.4 1216.4 1237.9 5892.6 5898.4 5926.9 5938.8 5945.0 6139.5 6345.9 6365.6 6374.2 6387.9 5863.8 5874.2 5892.5 5897.1 5915.2 3338.3 3341.0 3354.1 3365.7 3374.4 6347.8 6515.8 6553.1 6593.3 6619.2 6518.2 6544.9 6551.7 6555.2 6559.9 6293.9 6493.7 6566.8 6605.8 6629.4 6401.6 6403.5 6407.1 6428.5 6460.3 6218.3 6360.7 6399.9 6415.7 6419.7 6656.3 6667.2 6672.1 6686.6 6703.8 4530.8 4540.2 4564.9 4572.7 4579.0 6343.1 6354.5 6404.8 6419.6 6468.7 6251.7 6261.1 6263.7 6270.9 6274.2 6014.9 6212.5 6234.3 6268.8 6276.1 6231.9 6234.3 6246.9 6250.4 6256.8 6101.8 6272.4 6276.8 6297.1 6315.0 6078.4 6086.6 6089.6 6113.2 6115.5 16:36:24 INFO - PID 13421 | 16:36:24 INFO - PID 13421 | [#5] yui.html Cycles:180 Average:17980.15 Median:3284.66 stddev:22999.60 (700.2%) stddev-sans-first:23027.80 16:36:24 INFO - PID 13421 | Values: 766.6 769.3 772.0 779.9 797.4 16260.8 17028.1 17038.5 17055.5 17116.5 15689.6 15774.6 15988.2 15993.1 15993.6 928.9 931.0 967.3 974.6 979.3 974.9 975.1 976.1 976.4 976.4 1024.3 1025.6 1028.7 1029.8 1030.0 1015.4 1020.3 1021.6 1021.8 1022.4 741.2 746.9 747.1 747.3 747.5 16176.5 16310.4 16587.4 16670.8 16684.0 16129.4 16259.6 16260.7 16269.7 16411.6 11700.4 11858.9 12081.6 12541.8 12690.8 3126.3 3156.5 3271.4 3283.7 3285.6 84151.6 87483.6 87679.1 88585.6 88803.0 11760.8 11769.7 11847.8 11971.5 12548.8 24163.3 24229.0 24545.4 24553.6 24554.1 8131.4 8178.0 8240.1 8364.7 8407.4 4017.7 4043.9 4058.1 4071.2 4093.9 4262.9 4294.5 4295.9 4325.0 4362.7 730.9 733.9 754.4 763.8 773.2 636.7 643.5 653.2 662.2 663.2 10300.6 10710.6 10732.0 10834.3 10879.5 669.2 670.2 672.0 673.0 673.5 4476.8 4831.6 4847.1 4848.3 4876.8 77795.2 77933.3 79880.6 82283.6 85942.6 69432.0 73125.0 73223.6 75350.6 76854.0 62305.7 62965.0 63533.4 63897.7 63959.4 9703.6 9710.3 9837.6 9869.8 9873.2 30661.4 31182.7 32791.5 32818.7 33926.2 46297.8 47065.0 47893.2 48076.8 49979.3 14002.9 14022.8 14268.8 14488.2 15058.5 15298.9 15679.0 16063.2 16159.3 16592.4 15186.5 15262.0 15307.0 15591.1 15609.7 13216.2 13772.2 13796.8 13800.4 13839.8 13724.8 14330.6 14600.6 14752.5 14762.0 9848.7 10210.9 10227.5 10236.5 10249.1 9876.0 10888.2 10909.5 12193.0 12718.2 16:36:24 INFO - PID 13421 | -------- Summary: end -------- 16:36:24 INFO - PID 13421 | 16:36:25 INFO - TEST-INFO | 13421: exit 0 16:36:25 INFO - TEST-OK | dromaeo_css | took 1117707ms 16:36:25 INFO - TEST-START | kraken 16:36:25 INFO - operating with platform_type : linux_ 16:36:25 INFO - Initialising browser for kraken test... 16:36:25 INFO - TEST-INFO | started process 13745 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqoJA3S/profile http://localhost:58174/getInfo.html) 16:36:29 INFO - PID 13745 | __metrics Screen width/height:1600/1200 16:36:29 INFO - PID 13745 | colorDepth:24 16:36:29 INFO - PID 13745 | Browser inner width/height: 1024/697 16:36:29 INFO - PID 13745 | __metrics 16:36:30 ERROR - PID 13745 | 1490830590423 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) 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:96:5 < callBootstrapMethod@XPIProvider.jsm:4957:11 < observe@XPIProvider.jsm:2924: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 16:36:30 INFO - PID 13745 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:36:30 INFO - PID 13745 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:36:31 INFO - TEST-INFO | 13745: exit 0 16:36:31 INFO - Browser initialized. 16:36:31 INFO - Running cycle 1/1 for kraken test... 16:36:31 INFO - TEST-INFO | started process 13840 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqoJA3S/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:36:43 INFO - PID 13840 | RSS: Main: 144334848 16:36:43 INFO - PID 13840 | 16:36:46 INFO - PID 13840 | Cycle 1(1): loaded http://localhost:58174/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58174/tests/kraken/driver.html?testName=audio-beat-detection) 16:36:46 INFO - PID 13840 | RSS: Main: 200421376 16:36:46 INFO - PID 13840 | 16:36:49 INFO - PID 13840 | Cycle 1(1): loaded http://localhost:58174/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58174/tests/kraken/driver.html?testName=audio-dft) 16:36:50 INFO - PID 13840 | RSS: Main: 179789824 16:36:50 INFO - PID 13840 | 16:36:53 INFO - PID 13840 | Cycle 1(1): loaded http://localhost:58174/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58174/tests/kraken/driver.html?testName=audio-fft) 16:36:53 INFO - PID 13840 | RSS: Main: 261304320 16:36:53 INFO - PID 13840 | 16:36:55 INFO - PID 13840 | Cycle 1(1): loaded http://localhost:58174/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58174/tests/kraken/driver.html?testName=audio-oscillator) 16:36:56 INFO - PID 13840 | RSS: Main: 172089344 16:36:56 INFO - PID 13840 | 16:36:58 INFO - PID 13840 | Cycle 1(1): loaded http://localhost:58174/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58174/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:36:59 INFO - PID 13840 | RSS: Main: 176689152 16:36:59 INFO - PID 13840 | 16:37:02 INFO - PID 13840 | Cycle 1(1): loaded http://localhost:58174/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58174/tests/kraken/driver.html?testName=imaging-darkroom) 16:37:02 INFO - PID 13840 | RSS: Main: 215478272 16:37:02 INFO - PID 13840 | 16:37:06 INFO - PID 13840 | Cycle 1(1): loaded http://localhost:58174/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58174/tests/kraken/driver.html?testName=imaging-desaturate) 16:37:06 INFO - PID 13840 | RSS: Main: 229425152 16:37:06 INFO - PID 13840 | 16:37:09 INFO - PID 13840 | Cycle 1(1): loaded http://localhost:58174/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58174/tests/kraken/driver.html?testName=json-parse-financial) 16:37:10 INFO - PID 13840 | RSS: Main: 240922624 16:37:10 INFO - PID 13840 | 16:37:12 INFO - PID 13840 | Cycle 1(1): loaded http://localhost:58174/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58174/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:37:12 INFO - PID 13840 | RSS: Main: 178712576 16:37:12 INFO - PID 13840 | 16:37:14 INFO - PID 13840 | Cycle 1(1): loaded http://localhost:58174/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58174/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:37:14 INFO - PID 13840 | RSS: Main: 185315328 16:37:14 INFO - PID 13840 | 16:37:17 INFO - PID 13840 | Cycle 1(1): loaded http://localhost:58174/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58174/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:37:17 INFO - PID 13840 | RSS: Main: 194019328 16:37:17 INFO - PID 13840 | 16:37:20 INFO - PID 13840 | Cycle 1(1): loaded http://localhost:58174/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58174/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:37:21 INFO - PID 13840 | RSS: Main: 203812864 16:37:21 INFO - PID 13840 | 16:37:24 INFO - PID 13840 | Cycle 1(1): loaded http://localhost:58174/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58174/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:37:24 INFO - PID 13840 | RSS: Main: 200310784 16:37:24 INFO - PID 13840 | 16:37:26 INFO - PID 13840 | Cycle 1(1): loaded http://localhost:58174/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58174/tests/kraken/driver.html?testName=ai-astar) 16:37:26 INFO - PID 13840 | RSS: Main: 269778944 16:37:26 INFO - PID 13840 | 16:37:26 INFO - PID 13840 | __start_tp_report 16:37:26 INFO - PID 13840 | _x_x_mozilla_page_load 16:37:26 INFO - PID 13840 | _x_x_mozilla_page_load_details 16:37:26 INFO - PID 13840 | |i|pagename|runs| 16:37:26 INFO - PID 13840 | |0;ai-astar;102;110;110;110;111;110;110;109;110;110 16:37:26 INFO - PID 13840 | |1;audio-beat-detection;144;121;124;171;119;123;124;118;138;120 16:37:26 INFO - PID 13840 | |2;audio-dft;165;167;162;163;164;163;165;171;165;165 16:37:26 INFO - PID 13840 | |3;audio-fft;75;76;75;121;76;75;75;74;94;75 16:37:26 INFO - PID 13840 | |4;audio-oscillator;82;83;113;83;84;83;95;83;84;100 16:37:26 INFO - PID 13840 | |5;imaging-gaussian-blur;114;115;114;114;114;115;114;114;115;115 16:37:26 INFO - PID 13840 | |6;imaging-darkroom;148;148;150;148;149;148;148;148;147;147 16:37:26 INFO - PID 13840 | |7;imaging-desaturate;101;98;95;95;94;95;95;95;95;94 16:37:26 INFO - PID 13840 | |8;json-parse-financial;56;55;54;55;56;56;56;55;57;56 16:37:26 INFO - PID 13840 | |9;json-stringify-tinderbox;54;54;54;54;54;55;56;55;56;56 16:37:26 INFO - PID 13840 | |10;stanford-crypto-aes;88;81;80;79;82;81;80;80;86;80 16:37:26 INFO - PID 13840 | |11;stanford-crypto-ccm;128;129;145;127;126;127;127;133;181;129 16:37:26 INFO - PID 13840 | |12;stanford-crypto-pbkdf2;191;192;190;186;177;187;184;188;184;185 16:37:26 INFO - PID 13840 | |13;stanford-crypto-sha256-iterative;66;66;65;65;65;66;73;65;66;64 16:37:26 INFO - PID 13840 | __end_tp_report 16:37:26 INFO - PID 13840 | __start_cc_report 16:37:26 INFO - PID 13840 | _x_x_mozilla_cycle_collect,1747 16:37:26 INFO - PID 13840 | __end_cc_report 16:37:26 INFO - PID 13840 | __startTimestamp1490830646650__endTimestamp 16:37:26 INFO - PID 13840 | 16:37:26 INFO - PID 13840 | ------- Summary: start ------- 16:37:26 INFO - PID 13840 | Number of tests: 14 16:37:26 INFO - PID 13840 | 16:37:26 INFO - PID 13840 | [#0] ai-astar Cycles:10 Average:109.20 Median:110.00 stddev:2.57 (2.3%) stddev-sans-first:0.50 16:37:26 INFO - PID 13840 | Values: 102.0 110.0 110.0 110.0 111.0 110.0 110.0 109.0 110.0 110.0 16:37:26 INFO - PID 13840 | 16:37:26 INFO - PID 13840 | [#1] audio-beat-detection Cycles:10 Average:130.20 Median:124.00 stddev:16.69 (13.5%) stddev-sans-first:16.94 16:37:26 INFO - PID 13840 | Values: 144.0 121.0 124.0 171.0 119.0 123.0 124.0 118.0 138.0 120.0 16:37:26 INFO - PID 13840 | 16:37:26 INFO - PID 13840 | [#2] audio-dft Cycles:10 Average:165.00 Median:165.00 stddev:2.54 (1.5%) stddev-sans-first:2.69 16:37:26 INFO - PID 13840 | Values: 165.0 167.0 162.0 163.0 164.0 163.0 165.0 171.0 165.0 165.0 16:37:26 INFO - PID 13840 | 16:37:26 INFO - PID 13840 | [#3] audio-fft Cycles:10 Average:81.60 Median:75.00 stddev:15.07 (20.1%) stddev-sans-first:15.80 16:37:26 INFO - PID 13840 | Values: 75.0 76.0 75.0 121.0 76.0 75.0 75.0 74.0 94.0 75.0 16:37:26 INFO - PID 13840 | 16:37:26 INFO - PID 13840 | [#4] audio-oscillator Cycles:10 Average:89.00 Median:83.00 stddev:10.41 (12.5%) stddev-sans-first:10.73 16:37:26 INFO - PID 13840 | Values: 82.0 83.0 113.0 83.0 84.0 83.0 95.0 83.0 84.0 100.0 16:37:26 INFO - PID 13840 | 16:37:26 INFO - PID 13840 | [#5] imaging-gaussian-blur Cycles:10 Average:114.40 Median:114.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 16:37:26 INFO - PID 13840 | Values: 114.0 115.0 114.0 114.0 114.0 115.0 114.0 114.0 115.0 115.0 16:37:26 INFO - PID 13840 | 16:37:26 INFO - PID 13840 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 16:37:26 INFO - PID 13840 | Values: 148.0 148.0 150.0 148.0 149.0 148.0 148.0 148.0 147.0 147.0 16:37:26 INFO - PID 13840 | 16:37:26 INFO - PID 13840 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:95.00 stddev:2.16 (2.3%) stddev-sans-first:1.17 16:37:26 INFO - PID 13840 | Values: 101.0 98.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 94.0 16:37:26 INFO - PID 13840 | 16:37:26 INFO - PID 13840 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:56.00 stddev:0.84 (1.5%) stddev-sans-first:0.88 16:37:26 INFO - PID 13840 | Values: 56.0 55.0 54.0 55.0 56.0 56.0 56.0 55.0 57.0 56.0 16:37:26 INFO - PID 13840 | 16:37:26 INFO - PID 13840 | [#9] json-stringify-tinderbox Cycles:10 Average:54.80 Median:55.00 stddev:0.92 (1.7%) stddev-sans-first:0.93 16:37:26 INFO - PID 13840 | Values: 54.0 54.0 54.0 54.0 54.0 55.0 56.0 55.0 56.0 56.0 16:37:26 INFO - PID 13840 | 16:37:26 INFO - PID 13840 | [#10] stanford-crypto-aes Cycles:10 Average:81.70 Median:81.00 stddev:2.95 (3.6%) stddev-sans-first:2.06 16:37:26 INFO - PID 13840 | Values: 88.0 81.0 80.0 79.0 82.0 81.0 80.0 80.0 86.0 80.0 16:37:26 INFO - PID 13840 | 16:37:26 INFO - PID 13840 | [#11] stanford-crypto-ccm Cycles:10 Average:135.20 Median:129.00 stddev:17.04 (13.2%) stddev-sans-first:17.87 16:37:26 INFO - PID 13840 | Values: 128.0 129.0 145.0 127.0 126.0 127.0 127.0 133.0 181.0 129.0 16:37:26 INFO - PID 13840 | 16:37:26 INFO - PID 13840 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.40 Median:187.50 stddev:4.35 (2.3%) stddev-sans-first:4.28 16:37:26 INFO - PID 13840 | Values: 191.0 192.0 190.0 186.0 177.0 187.0 184.0 188.0 184.0 185.0 16:37:26 INFO - PID 13840 | 16:37:26 INFO - PID 13840 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.00 stddev:2.51 (3.8%) stddev-sans-first:2.67 16:37:26 INFO - PID 13840 | Values: 66.0 66.0 65.0 65.0 65.0 66.0 73.0 65.0 66.0 64.0 16:37:26 INFO - PID 13840 | -------- Summary: end -------- 16:37:26 INFO - PID 13840 | 16:37:27 INFO - TEST-INFO | 13840: exit 0 16:37:27 INFO - TEST-OK | kraken | took 62132ms 16:37:27 INFO - SUITE-END | took 1179s 16:37:27 INFO - Completed test suite (00:19:39) 16:37:27 INFO - javascript benchmark 16:37:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7590.780248252608, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3213.244887451449, 3260.967390326096, 3289.967100328996, 3292.5555050068233, 3292.5555050068233, 5662.122371032487, 5750.942490575104, 5899.351071382155, 5915.053591425372, 5921.822345329641, 5844.970775146118, 5870.970645146768, 5894.2042824218715, 5939.821805345847, 5982.820515384546, 5108.770105345268, 5144.897102057976, 5203.323567936182, 5229.267902493663, 5283.8111424929275, 5220.425753167167, 5263.736813159346, 5286.524212820846, 5290.391604965421, 5292.311999440087, 5052.292679024939, 5091.898162036776, 5124.180131179012, 5144.588432925357, 5148.742562871841, 5118.948810511884, 5128.435872054071, 5147.794088236466, 5149.124648809711, 5153.484651534854, 5078.085944529983, 5109.642325037249, 5114.7698353573805, 5121.308623335839, 5123.897522049539, 5675.262215911905, 5679.971600142014, 5680.261565996435, 5685.374608793029, 5691.6585004899425, 6050.6369617823075, 6100.572959892809, 6105.664188469633, 6110.266767987825, 6118.9694051529905, 6315.431611155018, 6338.556301058928, 6363.554551181419, 6384.585001974857, 6434.420902118832, 5903.49820265278, 5924.82225533226, 5925.762969481216, 5930.762769489215, 5983.640981541122, 6151.9692401538605, 6452.290248072708, 6491.610503369719, 6504.284528701839, 6504.447121994589, 5996.580239383288, 6095.529019716752, 6194.876102478015, 6194.907076393858, 6219.502439804804, 6330.525210609223, 6336.461400780893, 6340.587861789061, 6350.714217860207, 6351.396617321347, 6286.748530058838, 6317.9684101580115, 6319.431251187415, 6330.01884707871, 6337.714802833883, 6046.123312119718, 6105.8168254952425, 6117.908231376533, 6191.628502289787, 6243.875122497616, 4778.283257511401, 4800.3759511263315, 4800.975995120002, 4801.51984801517, 4838.903221935612, 4207.326827707552, 4213.241616508996, 4238.385434112037, 4252.043290259667, 4266.0, 5666.801661941812, 5687.289088863892, 5862.237909071793, 5913.704314784243, 5930.525557955353, 6303.432691057827, 6351.333110023474, 6354.936450635527, 6357.554971151975, 6364.331745166691, 5847.0, 5909.3795151508475, 5915.70421478933, 5919.852003699942, 5974.551908606872, 5126.359205099363, 5239.397469291081, 5321.281626980385, 5345.358556973188, 5350.3312085989255, 6449.0, 6559.639219842859, 6562.8359291018105, 6564.770233041821, 6572.375624315682, 6303.527235457267, 6344.619322840645, 6348.238211414659, 6352.968235158794, 6353.745850166127, 6195.783147589813, 6293.213348331458, 6293.937060629335, 6294.968525157528, 6465.77369792055, 6203.8138855834395, 6221.688915554114, 6227.595206311576, 6235.657038862906, 6248.4064013918605, 6338.683065846782, 6340.365963403623, 6340.4293613575, 6345.079963405188, 6360.427561519486, 5909.261342332208, 5916.171735957056, 6160.784372546939, 6167.074938759222, 6167.907481387693, 6131.284916201153, 6136.171616831849, 6171.290301615371, 6176.073588961692, 6181.752729890754, 6118.60229085108, 6139.293981192041, 6148.661823599745, 6163.414475624809, 6166.599171053867, 5912.674802885883, 6113.786017489367, 6197.163382943245, 6217.937820621736, 6232.501399888089, 5838.1826544282985, 5843.035899076604, 5843.035899076604, 5845.210896528914, 5857.560682948882], "value": 5730.481263965115, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [706.4630880530798, 763.8128658478672, 789.518393779794, 1124.3478782306263, 1131.6209069961562, 30957.690423095763, 31140.68859311406, 31166.376672466566, 31171.99999999997, 38278.617213827856, 41768.58231417685, 42065.57934420655, 42077.7896110519, 42119.36820947681, 42216.99999999992, 8237.052738935025, 8394.706185283516, 8404.1175676554, 8406.075331713506, 8407.24334809867, 6174.4134307240965, 6320.652364119972, 8109.472884262534, 8297.668093276261, 8307.875381869246, 8417.284530814888, 8463.703770368038, 8468.322534197281, 8476.067632560413, 8476.830463390728, 8367.330613550901, 8431.662733490653, 8439.915600844035, 8451.323894088458, 8454.61954212062, 8286.254237118688, 8319.66721331146, 8352.540610266433, 8362.16378362165, 8371.623276952552, 39268.80365598154, 39287.0, 39334.21331573353, 39433.60566394357, 39552.0, 2962.081754656042, 2965.1697524693122, 2973.3607274435885, 2980.3592227671156, 3007.443622929765, 28310.43887924622, 28331.57502637462, 28368.0, 28755.56866646981, 28877.278068048257, 3569.7501174917766, 3623.547056617923, 3658.1951970566433, 3683.7421380503374, 3697.8151092445537, 215018.0, 215033.0, 215120.0, 216265.0, 216932.0, 48784.26823597649, 48869.755651221516, 48893.511064888895, 48904.7554762231, 49041.754791225816, 51953.220701689504, 51976.0, 52058.0, 52077.7396113017, 52135.0, 13955.860441395456, 14300.785488217685, 14320.283985800668, 14339.139651620937, 14364.138151710931, 11316.207865449504, 11387.0, 11394.886051139383, 11395.487203075882, 11415.143864210051, 11656.358900260568, 11940.402979850973, 12988.415521301564, 13093.607191784262, 13376.866231337563, 5117.718525481134, 5268.341457317835, 5278.81524146653, 5284.5772338212855, 5314.97342513285, 1024.994875025635, 1041.6250149946013, 1059.6105781462907, 1062.7024433158729, 1082.8375743638517, 25667.614985775228, 25730.228093157235, 25741.3564660885, 26008.21975340705, 26017.219483415527, 1137.221003612528, 1153.6654370232538, 1155.942202889852, 1162.4826952006445, 1182.0872910665723, 13095.607131786062, 13371.06402551812, 13378.331083445983, 13500.257485838176, 13502.797458038138, 293185.0, 294280.0, 294335.0, 294969.0, 295154.0, 54415.72792136014, 54480.18279725807, 54525.45474545283, 54564.18153727697, 54604.45395546073, 1389.666480044782, 1461.228148812196, 1477.7044591081826, 1495.4691084665005, 1510.8035955325738, 23328.766712333338, 24060.674224403258, 24434.877825610758, 24474.51050979006, 24627.630585540872, 39592.208155837296, 39865.2026959465, 39868.60131398649, 39905.800470997456, 39937.201255974134, 302779.0, 304798.0, 305746.0, 306097.0, 307631.0, 33748.325033499685, 34313.48529772006, 34415.65584344225, 34440.82779586086, 34465.31069378548, 40552.797236013634, 40960.38559421551, 41090.0, 41225.587744122175, 41898.0, 31443.685563144074, 31562.842185788923, 31582.36835263328, 32133.517997229592, 33324.333513330086, 31871.0, 31909.840450797597, 32248.83875580607, 33103.66896331006, 33223.66776332206, 37182.25635487221, 37431.25137497289, 37597.81201093977, 38198.80900595479, 38296.0, 29699.703002969694, 30628.84685576558, 30838.845805770827, 30984.845075774476, 31646.683533165295, 25219.369515762253, 25278.74721252764, 25450.872745636152, 25494.362640934127, 25701.742982569936], "value": 17357.14379444598, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.90516418313325, 430.4920194170877, 449.28339298818395, 463.33974086926133, 465.20450030447955, 15564.533064008097, 19553.804461955377, 20112.59774804505, 20934.685979710277, 21363.252286169987, 16072.116033618146, 17581.472555823315, 21992.45018874529, 22050.558988820216, 22294.777052229474, 5764.250647415841, 6002.759889604411, 6008.909866352008, 6009.1587177795145, 6011.398860113997, 5700.914486282688, 5781.277340332458, 5802.419758024185, 5811.593188476808, 5888.411158884121, 5764.279465066867, 5778.913316300259, 5799.73901174446, 5805.071188609823, 5811.970940145294, 5739.741711622987, 5763.1067184586245, 5793.681347525863, 5914.2015827863115, 5919.585629005971, 5139.306193663845, 5353.785848566053, 5370.113931201347, 5382.973085134549, 5383.650062745909, 24230.7576924232, 24493.87753061241, 24534.754652453605, 24728.13451529206, 24744.13395531166, 1969.8227159555709, 1973.2850621127272, 1992.2031187525106, 2009.7789243183238, 2030.0255877179036, 15360.0, 15902.204889755465, 16032.75950860738, 16103.516894493185, 16658.0838053907, 1876.8780029298189, 1923.85571082168, 1950.8146726061002, 1963.6465436221474, 1971.8126777956215, 94847.0, 96269.0, 98047.0, 99717.0, 100401.0, 11020.173486988508, 12133.393330333625, 12185.878141218474, 12207.938960305319, 12232.266064036186, 16322.75515867263, 16814.915925420293, 17447.73828392575, 17535.0, 17542.561435964202, 8592.44149130317, 8630.136986301319, 8845.203931646054, 8919.554022298858, 8959.372843900865, 7985.760427187193, 8046.356291496666, 8072.240522667339, 8312.8753068704, 8351.540665263468, 7304.926950730424, 7489.28851759082, 7573.810654733566, 7574.166841647414, 7691.1155217150745, 2165.43698638352, 2167.7318768520277, 2185.748638906546, 2196.5716685246225, 2236.4632488203038, 1003.4280460137652, 1025.7128004158847, 1038.8078205532001, 1043.4209013997304, 1045.9320144190756, 18974.620507590047, 19699.507512312306, 19753.901230494044, 19909.701354479694, 20025.599488010448, 1033.4677641014882, 1038.08129805123, 1043.2749239278628, 1052.3054783842626, 1065.9040686338267, 9887.950560247296, 10844.349339039525, 11884.881151188378, 13055.21668699881, 13237.139585926883, 629143.0, 631366.0, 632101.0, 632200.0, 643551.0, 106827.46586267019, 107086.46456767822, 110117.44941275242, 111028.44485777519, 112536.0, 1177.6996865799167, 1204.7891618966646, 1212.799888018467, 1246.4453318273281, 1248.3196657821509, 18929.716054258923, 19098.23607055702, 19479.415617531497, 19708.901455493204, 19745.308914187935, 50863.74568127136, 51111.32091410129, 51804.0, 51940.74029629979, 52706.0, 64810.0, 66184.0, 66969.75135092092, 67770.3222967764, 69262.0, 8850.95574522149, 8866.246369058703, 8872.423292485968, 9096.363254572381, 9369.203617692572, 13331.933340333237, 13388.0, 13545.577714340247, 13844.861551384358, 13941.163530188222, 11556.94221528887, 11637.127215458706, 11719.88280117188, 11934.104942129201, 11981.221220620631, 11092.168087393316, 11152.49813758399, 11269.154813388865, 11407.144464165387, 11425.428728563706, 11983.400829958642, 12167.148299618942, 12223.327716975651, 12328.260304381407, 12443.315617641116, 8898.822023559364, 8947.150020748279, 8965.282777377925, 9125.908740912771, 9474.052594740471, 11770.411479426166, 11962.342071186169, 12143.75712485763, 12158.696032599255, 12269.325187114795], "value": 10046.512161411541, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1308.3915979069734, 1369.5412036967616, 1383.2668685596632, 1391.0401822742313, 1392.380390726127, 10663.680089597305, 11118.722031949206, 11124.666260012193, 11144.777104457906, 11144.832827507584, 10942.124630029599, 11082.445877706123, 11392.430378481064, 11457.0, 11465.312081275108, 2355.2110043135526, 2395.646459750244, 2398.70016247969, 2400.579898517761, 2403.0507949359994, 1985.6128055029276, 2225.9109635614554, 2316.7683231676783, 2352.717673879128, 2359.7876191142796, 2033.1968872295433, 2268.6937263469385, 2354.2584086012935, 2357.363511851799, 2360.24472168906, 2223.8665680059084, 2307.2501437032947, 2311.3181611424584, 2316.9884150579223, 2321.2455951815728, 2272.8295377846725, 2280.0879648140876, 2281.9543609127722, 2284.1662793080404, 2301.6432452969816, 11133.0, 11230.606928757454, 11233.438328083563, 11237.26957747752, 11243.943780281046, 5896.616719913192, 6112.694365281763, 6119.5104391648565, 6123.081537769326, 6126.417990290915, 3539.07983924179, 3559.875404360861, 3725.795081270529, 3730.1607138393915, 3753.5871054184017, 1282.33959510852, 1340.9530666426629, 1348.7369962857247, 1395.2674845705983, 1403.0669604712855, 16374.263158157792, 16509.257083431155, 16553.172341382884, 16568.75146872786, 16571.751423728652, 5245.501677340647, 5370.865728356823, 5465.535429488458, 5729.713514324267, 5756.194132821408, 12598.81101783474, 12715.682107947376, 12728.80906786399, 12731.23612583248, 12735.745285094246, 6229.844253893598, 6239.188905442355, 6243.157173781481, 6248.843778905563, 6253.96873015632, 5676.318841738936, 5776.393478684761, 5809.796657116981, 5813.069908814569, 5829.329627092939, 4104.52797928242, 4242.53332133465, 4291.635211007099, 4368.737875727466, 4454.042380888124, 1053.6259627832162, 1231.9322437265857, 1275.069199484363, 1283.9471633260637, 1287.549357724789, 735.5880706804206, 840.2521755637488, 845.9703910363107, 866.7226487524058, 887.1128871128872, 6022.638641681513, 6132.50939924805, 6200.658963756947, 6271.247450305901, 6401.775937842246, 919.5034681272172, 927.9443233406017, 946.0964778636386, 954.2270760683869, 964.3827950111934, 4252.617264446215, 4449.555044495524, 4481.2381895077915, 4516.277395616686, 4520.728756274634, 14199.148051116967, 14680.192589407472, 14746.18895960711, 14754.262286885612, 14773.778393324108, 13954.162750235018, 14501.637459063608, 14543.127412355292, 14562.0, 14572.85427145715, 10275.434851083113, 10427.68716938493, 10539.473026348805, 10549.47252637365, 10614.203934704929, 6531.281559028408, 7092.680829362588, 7197.064381630355, 7217.963910180415, 7293.4894557382595, 12953.287569183785, 12998.545050923172, 13076.476940922257, 13356.198628082346, 13374.465021399035, 13311.933440332736, 13407.195568265935, 13434.193948363129, 13548.051636385359, 13651.453941842215, 9386.108319709616, 9441.10309520622, 9512.762180945532, 9599.520023998912, 9601.039896010623, 10295.12491438236, 10360.585576577154, 10515.421651809223, 10527.0, 10531.578736850746, 6900.137482814648, 8282.088970213392, 8680.088590697886, 8751.256143227896, 8935.0, 8229.83540329202, 8401.915980840113, 8546.35902307317, 8666.220040196413, 8707.738767836974, 7272.636368181464, 7282.708691652275, 7305.817354566178, 7416.851662966818, 7462.44031697614, 5941.643501389757, 5969.557437907958, 5981.102834574848, 6046.94629212245, 6072.210612620508, 5990.191324171181, 6109.7861574844665, 6111.480524155497, 6188.4739797117745, 6290.109146626742], "value": 5264.329695045054, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [416.1365167277898, 418.9651560645206, 419.19096144441255, 425.24230366075994, 429.14814094023376, 5889.146073819294, 5980.342162362137, 5992.5505587080925, 6007.5494337924665, 6016.338202797689, 5876.412358764122, 5878.794242201524, 5901.793437229687, 5909.8227053188475, 5927.2887253529525, 4395.494518130424, 4532.161550113223, 4545.431821022372, 4560.179167749804, 4643.628509719223, 4498.122866041123, 4543.522930092342, 4550.497226525398, 4553.658475614326, 4555.954440455603, 4501.594856462918, 4537.75042372671, 4538.387317712116, 4543.886402839922, 4554.43069616298, 4412.8455504057365, 4506.098780243931, 4526.456825180966, 4528.8867778305475, 4542.727436353813, 3959.1883663848844, 3969.186316805077, 3979.283728928792, 3984.322665146903, 3985.980070099631, 5673.971630141864, 5692.37383887772, 5727.427257274281, 5730.856728581777, 5752.7986520472, 5138.691942184762, 5263.499967503081, 5283.445238249967, 5293.258943747878, 5318.867028324285, 6199.101130336121, 6212.254529456494, 6216.440520353145, 6226.252849658024, 6249.500039996789, 4428.40216570762, 4448.4439445069365, 4467.82128714851, 4470.8435204768, 4479.0, 6206.627602343829, 6295.213098362705, 6354.586951848161, 6526.869462610721, 6561.179852518435, 4763.904721905543, 4808.2787581863, 4812.326274321597, 4856.854294371175, 4873.488283730228, 4911.484294149134, 4925.162722337212, 4945.802167913315, 4951.826686066042, 4952.950470495249, 5274.839535302227, 5378.865528361822, 5467.261919640877, 5478.164814787091, 5487.368952570426, 6237.656928868956, 6252.874942501216, 6270.99328214976, 6287.591306565058, 6295.118683384329, 1680.4118558504426, 1689.8901571398067, 1693.9407120750714, 1697.2786565709523, 1700.498352985872, 1189.411241435495, 1210.7396909664287, 1213.3508572913624, 1216.416120262279, 1237.9071569632133, 5892.558058145656, 5898.4101589840675, 5926.881462370815, 5938.8218353449465, 5945.0, 6139.508839292846, 6345.936540634534, 6365.649889256136, 6374.171357723466, 6387.936120638827, 5863.765449381977, 5874.236349274567, 5892.469677728939, 5897.115432685132, 5915.1718759373725, 3338.2989572190113, 3341.0, 3354.111160542458, 3365.730741540671, 3374.4263475209273, 6347.809565713036, 6515.771947981798, 6553.148090748172, 6593.274739778621, 6619.172603424572, 6518.217813862367, 6544.869102617921, 6551.672416379257, 6555.246146693191, 6559.934400656028, 6293.874122517615, 6493.740250390026, 6566.770163044366, 6605.801825945229, 6629.436497897733, 6401.583897046677, 6403.4877209824035, 6407.10300557913, 6428.517861160338, 6460.289368169591, 6218.253809542703, 6360.681965901594, 6399.904001440075, 6415.711292991733, 6419.688911991772, 6656.301088385843, 6667.19993600771, 6672.131803094947, 6686.5653732507235, 6703.765368212285, 4530.841420550397, 4540.228161212536, 4564.931526027046, 4572.6799124061, 4579.0, 6343.111964324906, 6354.459870911024, 6404.775832845828, 6419.550631455753, 6468.708908099241, 6251.6558939828155, 6261.123442718114, 6263.74945002213, 6270.905936410866, 6274.184356033869, 6014.9097763534455, 6212.502999760099, 6234.251889773256, 6268.811935641938, 6276.117164850435, 6231.937680623136, 6234.3453937337745, 6246.937530624818, 6250.406211409909, 6256.843578910563, 6101.7559297627595, 6272.435480806749, 6276.780312689034, 6297.118403423616, 6314.989601663712, 6078.422549857756, 6086.60437071589, 6089.634621922699, 6113.174721412553, 6115.480184184395], "value": 4799.663424987951, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [766.5630590563378, 769.3153093746563, 771.9691212351506, 779.8557266905623, 797.4378063465253, 16260.75608865868, 17028.148592570386, 17038.48884533463, 17055.488335349928, 17116.486505404842, 15689.607759806011, 15774.605634859134, 15988.200589970513, 15993.120378379184, 15993.600159996005, 928.9071092890707, 930.9720708378726, 967.3132076225888, 974.585801034561, 979.2900147393154, 974.926880483963, 975.0931633580767, 976.053228368485, 976.3995142987083, 976.4434272464698, 1024.3188279793928, 1025.6307729217476, 1028.686250693538, 1029.8146333659938, 1029.97002997003, 1015.3806178231273, 1020.3010937507831, 1021.5709402051119, 1021.780317231795, 1022.3763504262394, 741.1883987034189, 746.9327760501527, 747.1221314954961, 747.3348719639525, 747.4618274842105, 16176.514704558764, 16310.429134980337, 16587.419440319532, 16670.833291667048, 16684.0, 16129.435469758502, 16259.593510162222, 16260.674786504203, 16269.674606507804, 16411.58971025722, 11700.414979251003, 11858.940705296418, 12081.637550873487, 12541.811872821914, 12690.809637855347, 3126.265327648001, 3156.526521021842, 3271.4275001874817, 3283.688049635281, 3285.6221534523356, 84151.57924210401, 87483.56258218733, 87679.12320876773, 88585.55707221487, 88803.0, 11760.764784704257, 11769.705757355963, 11847.763044739057, 11971.46128424223, 12548.81176782349, 24163.275101746625, 24229.0, 24545.440911067795, 24553.631695524582, 24554.140605078737, 8131.390145739093, 8178.0, 8240.13478584752, 8364.665413383396, 8407.369447291478, 4017.738846974937, 4043.8786836394956, 4058.1477889642915, 4071.246819338432, 4093.89765255871, 4262.850800221977, 4294.484661840599, 4295.892602684896, 4325.048489332342, 4362.716423432466, 730.8830587106144, 733.8825787873915, 754.4190972950797, 763.7861398808343, 773.161120184606, 636.6689321552859, 643.530222937249, 653.2491982626107, 662.2185820731487, 663.2339647706906, 10300.639477618248, 10710.581041576623, 10731.980461856112, 10834.295770774874, 10879.456027198608, 669.1735706402588, 670.1589505170979, 671.9798406047827, 672.9629870357178, 673.4511373230802, 4476.776161191928, 4831.5651591356245, 4847.127517046965, 4848.254818040633, 4876.792902162153, 77795.22204777993, 77933.27233546799, 79880.60059699665, 82283.5885820567, 85942.57028714816, 69432.0, 73125.0, 73223.63388183025, 75350.62324688342, 76854.0, 62305.688471557354, 62965.0, 63533.36466635275, 63897.680511598075, 63959.3604063972, 9703.563339649592, 9710.320277580502, 9837.557309920927, 9869.753256168366, 9873.160781333667, 30661.386772264876, 31182.68817311798, 32791.50812737763, 32818.67181328156, 33926.15184620306, 46297.76851115723, 47065.0, 47893.16854651689, 48076.75961620169, 49979.25031124609, 14002.859971400563, 14022.789658154932, 14268.785968210277, 14488.203148826915, 15058.536536596424, 15298.93350219174, 15679.0, 16063.188941935348, 16159.27283272279, 16592.419265325654, 15186.46847360337, 15262.0, 15307.0, 15591.14248716286, 15609.68780624404, 13216.207027578375, 13772.24252666113, 13796.793048104086, 13800.378982945993, 13839.792403113759, 13724.794128088286, 14330.57008289753, 14600.634984125481, 14752.483663071742, 14762.0, 9848.680165797434, 10210.897891020995, 10227.488625568543, 10236.53935572886, 10249.12882405004, 9876.0, 10888.18338624622, 10909.490377797669, 12193.0, 12718.236905785683], "value": 7576.156247736204, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1513.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 110.0, 110.0, 110.0, 111.0, 110.0, 110.0, 109.0, 110.0, 110.0], "value": 109.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 121.0, 124.0, 171.0, 119.0, 123.0, 124.0, 118.0, 138.0, 120.0], "value": 130.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 167.0, 162.0, 163.0, 164.0, 163.0, 165.0, 171.0, 165.0, 165.0], "value": 165.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 121.0, 76.0, 75.0, 75.0, 74.0, 94.0, 75.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 113.0, 83.0, 84.0, 83.0, 95.0, 83.0, 84.0, 100.0], "value": 89.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 114.0, 114.0, 115.0, 114.0, 114.0, 115.0, 115.0], "value": 114.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 150.0, 148.0, 149.0, 148.0, 148.0, 148.0, 147.0, 147.0], "value": 148.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 98.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 54.0, 55.0, 56.0, 56.0, 56.0, 55.0, 57.0, 56.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 54.0, 54.0, 55.0, 56.0, 55.0, 56.0, 56.0], "value": 54.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 81.0, 80.0, 79.0, 82.0, 81.0, 80.0, 80.0, 86.0, 80.0], "value": 81.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 129.0, 145.0, 127.0, 126.0, 127.0, 127.0, 133.0, 181.0, 129.0], "value": 135.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [191.0, 192.0, 190.0, 186.0, 177.0, 187.0, 184.0, 188.0, 184.0, 185.0], "value": 186.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 65.0, 65.0, 66.0, 73.0, 65.0, 66.0, 64.0], "value": 66.1, "unit": "score"}]}]} 16:37:27 INFO - Return code: 0 16:37:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:37:27 ERROR - # TBPL SUCCESS # 16:37:27 INFO - Running post-action listener: _resource_record_post_action 16:37:27 INFO - [mozharness: 2017-03-29 23:37:27.940560Z] Finished run-tests step (success) 16:37:27 INFO - Running post-run listener: _resource_record_post_run 16:37:28 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 369737728; Read time: 12; Write time: 307684 16:37:28 INFO - TinderboxPrint: CPU usage
13.0% 16:37:28 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 16:37:28 INFO - TinderboxPrint: I/O write bytes / time
369,737,728 / 307,684 16:37:28 INFO - TinderboxPrint: CPU idle
8,311.3 (87.0%) 16:37:28 INFO - TinderboxPrint: CPU user
1,194.0 (12.5%) 16:37:28 INFO - TinderboxPrint: Swap in / out
0 / 0 16:37:28 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 112349184; Read time: 0; Write time: 125056 16:37:28 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 257388544; Read time: 0; Write time: 182628 16:37:28 INFO - Running post-run listener: _upload_blobber_files 16:37:28 INFO - Blob upload gear active. 16:37:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:37:28 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 16:37:28 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'] 16:37:28 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 16:37:29 INFO - (blobuploader) - INFO - Open directory for files ... 16:37:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:37:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:37:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:37:30 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:37:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:37:30 INFO - (blobuploader) - INFO - Done attempting. 16:37:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:37:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:37:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:37:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:37:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:37:31 INFO - (blobuploader) - INFO - Done attempting. 16:37:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:37:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:37:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:37:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:37:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:37:32 INFO - (blobuploader) - INFO - Done attempting. 16:37:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:37:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:37:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:37:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:37:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:37:35 INFO - (blobuploader) - INFO - Done attempting. 16:37:35 INFO - (blobuploader) - INFO - Iteration through files over. 16:37:35 INFO - Return code: 0 16:37:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:37:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:37:35 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a62ee52b22627a8d44965d51a341b9a6a8e3ab60a0eae1514e3356dfae9a96346a89d17c9f1c3945589c62796f4fc13d8daee81887ed5d1d48f09cc9b4762abc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/47b5723f08f1d43d49e69fa54b39eb6926d2d3b16882d9d95e789c390d8f69b0e59a9b79ff5cdd7fb3016e94f02b04e22fc22e44af776096899885378ab3a978", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1644503045a0ed31c74b7a9cd5d660547f03ef40247e78847745ede161bb917ff99921a767ec88e3902583a937e9a3e28757ca95220217a2ee2f4970730c0f3f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07d99dd5f666d2e4a5f26a8771e2d34dacfea5a692c26210f1fa3c39eb71912253f4433b56f84aeb6bbbf4e7773c093b59dab93f0f535d9040f0d5d34a34c66e"} 16:37:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:37:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:37:35 INFO - Contents: 16:37:35 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a62ee52b22627a8d44965d51a341b9a6a8e3ab60a0eae1514e3356dfae9a96346a89d17c9f1c3945589c62796f4fc13d8daee81887ed5d1d48f09cc9b4762abc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/47b5723f08f1d43d49e69fa54b39eb6926d2d3b16882d9d95e789c390d8f69b0e59a9b79ff5cdd7fb3016e94f02b04e22fc22e44af776096899885378ab3a978", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1644503045a0ed31c74b7a9cd5d660547f03ef40247e78847745ede161bb917ff99921a767ec88e3902583a937e9a3e28757ca95220217a2ee2f4970730c0f3f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07d99dd5f666d2e4a5f26a8771e2d34dacfea5a692c26210f1fa3c39eb71912253f4433b56f84aeb6bbbf4e7773c093b59dab93f0f535d9040f0d5d34a34c66e"} 16:37:35 INFO - Running post-run listener: copy_logs_to_upload_dir 16:37:35 INFO - Copying logs to upload dir... 16:37:35 INFO - mkdir: /builds/slave/test/build/upload/logs 16:37:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.939479 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-03-29 16:37:35.700495) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-29 16:37:35.703568) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1490829396.431613-2121658179 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/a62ee52b22627a8d44965d51a341b9a6a8e3ab60a0eae1514e3356dfae9a96346a89d17c9f1c3945589c62796f4fc13d8daee81887ed5d1d48f09cc9b4762abc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/47b5723f08f1d43d49e69fa54b39eb6926d2d3b16882d9d95e789c390d8f69b0e59a9b79ff5cdd7fb3016e94f02b04e22fc22e44af776096899885378ab3a978", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1644503045a0ed31c74b7a9cd5d660547f03ef40247e78847745ede161bb917ff99921a767ec88e3902583a937e9a3e28757ca95220217a2ee2f4970730c0f3f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07d99dd5f666d2e4a5f26a8771e2d34dacfea5a692c26210f1fa3c39eb71912253f4433b56f84aeb6bbbf4e7773c093b59dab93f0f535d9040f0d5d34a34c66e"} build_url:https://queue.taskcluster.net/v1/task/frqLWP9oTZquTIy_-idEqg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011152 build_url: 'https://queue.taskcluster.net/v1/task/frqLWP9oTZquTIy_-idEqg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a62ee52b22627a8d44965d51a341b9a6a8e3ab60a0eae1514e3356dfae9a96346a89d17c9f1c3945589c62796f4fc13d8daee81887ed5d1d48f09cc9b4762abc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/47b5723f08f1d43d49e69fa54b39eb6926d2d3b16882d9d95e789c390d8f69b0e59a9b79ff5cdd7fb3016e94f02b04e22fc22e44af776096899885378ab3a978", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1644503045a0ed31c74b7a9cd5d660547f03ef40247e78847745ede161bb917ff99921a767ec88e3902583a937e9a3e28757ca95220217a2ee2f4970730c0f3f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07d99dd5f666d2e4a5f26a8771e2d34dacfea5a692c26210f1fa3c39eb71912253f4433b56f84aeb6bbbf4e7773c093b59dab93f0f535d9040f0d5d34a34c66e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-29 16:37:35.728149) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 16:37:35.728473) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1490829396.431613-2121658179 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004442 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 16:37:35.812037) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-29 16:37:35.812382) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-29 16:37:35.812662) ========= ========= Total master_lag: 0.16 =========