builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-063 starttime: 1484088063.39 results: success (0) revision: 20094311ab5ec56d5be7afc6d5c2e2b09e656fb2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-10 14:41:03.388952) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-10 14:41:03.389463) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-10 14:41:03.389749) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-10 14:41:03.404592) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 14:41:03.405014) ========= 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=769a0cfe1e83e11e6f11f5a3000001a8-1484088062.801529-1647687941 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-10 14:41:03-- 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% 46.4M=0s 2017-01-10 14:41:03 (46.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.148212 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 14:41:03.566797) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 14:41:03.567138) ========= 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=769a0cfe1e83e11e6f11f5a3000001a8-1484088062.801529-1647687941 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014278 ========= master_lag: 0.12 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 14:41:03.697940) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 14:41:03.698293) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 20094311ab5ec56d5be7afc6d5c2e2b09e656fb2 --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 20094311ab5ec56d5be7afc6d5c2e2b09e656fb2 --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=769a0cfe1e83e11e6f11f5a3000001a8-1484088062.801529-1647687941 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-10 14:41:03,910 truncating revision to first 12 chars 2017-01-10 14:41:03,910 Setting DEBUG logging. 2017-01-10 14:41:03,910 attempt 1/10 2017-01-10 14:41:03,910 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/20094311ab5e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-10 14:41:04,494 unpacking tar archive at: mozilla-central-20094311ab5e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.889053 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 14:41:04.600625) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-10 14:41:04.600949) ========= script_repo_revision: 20094311ab5ec56d5be7afc6d5c2e2b09e656fb2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-10 14:41:04.601374) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-10 14:41:04.601650) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-10 14:41:04.609805) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-01-10 14:41:04.610213) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=769a0cfe1e83e11e6f11f5a3000001a8-1484088062.801529-1647687941 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:41:04 INFO - MultiFileLogger online at 20170110 14:41:04 in /builds/slave/test 14:41:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 14:41:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:41:04 INFO - {'append_to_log': False, 14:41:04 INFO - 'base_work_dir': '/builds/slave/test', 14:41:04 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 14:41:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:41:04 INFO - 'branch': 'Firefox-Non-PGO', 14:41:04 INFO - 'buildbot_json_path': 'buildprops.json', 14:41:04 INFO - 'config_files': ('talos/linux_config.py',), 14:41:04 INFO - 'default_actions': ('clobber', 14:41:04 INFO - 'read-buildbot-config', 14:41:04 INFO - 'download-and-extract', 14:41:04 INFO - 'populate-webroot', 14:41:04 INFO - 'create-virtualenv', 14:41:04 INFO - 'install', 14:41:04 INFO - 'run-tests'), 14:41:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:41:04 INFO - 'download_minidump_stackwalk': True, 14:41:04 INFO - 'download_symbols': 'ondemand', 14:41:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:41:04 INFO - 'tooltool.py': '/tools/tooltool.py', 14:41:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:41:04 INFO - '/tools/misc-python/virtualenv.py')}, 14:41:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:41:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:41:04 INFO - 'installer_path': 'installer.exe', 14:41:04 INFO - 'log_level': 'info', 14:41:04 INFO - 'log_name': 'talos', 14:41:04 INFO - 'log_to_console': True, 14:41:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:41:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:41:04 INFO - 'opt_config_files': (), 14:41:04 INFO - 'pip_index': False, 14:41:04 INFO - 'sps_profile': False, 14:41:04 INFO - 'sps_profile_interval': 0, 14:41:04 INFO - 'suite': 'dromaeojs', 14:41:04 INFO - 'system_bits': '32', 14:41:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:41:04 INFO - 'title': 'talos-linux64-ix-063', 14:41:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:41:04 INFO - 'use_talos_json': True, 14:41:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:41:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:41:04 INFO - 'work_dir': 'build'} 14:41:04 INFO - [mozharness: 2017-01-10 22:41:04.913634Z] Running clobber step. 14:41:04 INFO - Running pre-action listener: _resource_record_pre_action 14:41:04 INFO - Running main action method: clobber 14:41:04 INFO - rmtree: /builds/slave/test/build 14:41:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:41:05 INFO - Running post-action listener: _resource_record_post_action 14:41:05 INFO - [mozharness: 2017-01-10 22:41:05.371109Z] Finished clobber step (success) 14:41:05 INFO - [mozharness: 2017-01-10 22:41:05.371211Z] Running read-buildbot-config step. 14:41:05 INFO - Running pre-action listener: _resource_record_pre_action 14:41:05 INFO - Running main action method: read_buildbot_config 14:41:05 INFO - Using buildbot properties: 14:41:05 INFO - { 14:41:05 INFO - "project": "", 14:41:05 INFO - "product": "firefox", 14:41:05 INFO - "who": "kwierso@gmail.com", 14:41:05 INFO - "installer_path": "public/build/target.tar.bz2", 14:41:05 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 14:41:05 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 14:41:05 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 14:41:05 INFO - "stage_platform": "linux64", 14:41:05 INFO - "basedir": "/builds/slave/test", 14:41:05 INFO - "buildnumber": 772, 14:41:05 INFO - "platform": "ubuntu64_hw", 14:41:05 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:41:05 INFO - "slavebuilddir": "test", 14:41:05 INFO - "taskId": "ZmLXs82DSY-4OFTQ89U3ew", 14:41:05 INFO - "branch": "mozilla-central", 14:41:05 INFO - "script_repo_revision": "production", 14:41:05 INFO - "revision": "20094311ab5ec56d5be7afc6d5c2e2b09e656fb2", 14:41:05 INFO - "slavename": "talos-linux64-ix-063", 14:41:05 INFO - "repo_path": "mozilla-central" 14:41:05 INFO - } 14:41:05 INFO - Finding installer, test and symbols from parent task. 14:41:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZmLXs82DSY-4OFTQ89U3ew'}, attempt #1 14:41:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZmLXs82DSY-4OFTQ89U3ew'}, attempt #1 14:41:06 INFO - Task dependencies: EcywXawJSIuho9G_imj5qg 14:41:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EcywXawJSIuho9G_imj5qg'}, attempt #1 14:41:06 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/EcywXawJSIuho9G_imj5qg/artifacts/public/build/target.tar.bz2 14:41:06 INFO - Set test_url: https://queue.taskcluster.net/v1/task/EcywXawJSIuho9G_imj5qg/artifacts/public/build/test_packages.json 14:41:06 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/EcywXawJSIuho9G_imj5qg/artifacts/public/build/target.crashreporter-symbols.zip 14:41:06 INFO - Running post-action listener: _resource_record_post_action 14:41:06 INFO - [mozharness: 2017-01-10 22:41:06.795127Z] Finished read-buildbot-config step (success) 14:41:06 INFO - [mozharness: 2017-01-10 22:41:06.795343Z] Running download-and-extract step. 14:41:06 INFO - Running pre-action listener: _resource_record_pre_action 14:41:06 INFO - Running main action method: download_and_extract 14:41:06 INFO - mkdir: /builds/slave/test/build/tests 14:41: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')]} 14:41:06 INFO - trying https://queue.taskcluster.net/v1/task/EcywXawJSIuho9G_imj5qg/artifacts/public/build/target.test_packages.json 14:41:06 INFO - Downloading https://queue.taskcluster.net/v1/task/EcywXawJSIuho9G_imj5qg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 14:41:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EcywXawJSIuho9G_imj5qg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 14:41:07 INFO - Downloaded 896 bytes. 14:41:07 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 14:41:07 INFO - Using the following test package requirements: 14:41:07 INFO - {u'common': [u'target.common.tests.zip'], 14:41:07 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 14:41:07 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 14:41:07 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 14:41:07 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 14:41:07 INFO - u'mozbase': [u'target.common.tests.zip'], 14:41:07 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 14:41:07 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 14:41:07 INFO - u'web-platform': [u'target.common.tests.zip', 14:41:07 INFO - u'target.web-platform.tests.zip'], 14:41:07 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 14:41:07 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 14:41:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EcywXawJSIuho9G_imj5qg/artifacts/public/build/target.common.tests.zip 14:41:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EcywXawJSIuho9G_imj5qg/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:41:07 INFO - Fetch https://queue.taskcluster.net/v1/task/EcywXawJSIuho9G_imj5qg/artifacts/public/build/target.common.tests.zip into memory 14:41:08 INFO - Expected file size: 20256464 14:41:08 INFO - Obtained file size: 20256464 14:41:12 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 14:41:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EcywXawJSIuho9G_imj5qg/artifacts/public/build/target.common.tests.zip 14:41:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EcywXawJSIuho9G_imj5qg/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:41:12 INFO - Fetch https://queue.taskcluster.net/v1/task/EcywXawJSIuho9G_imj5qg/artifacts/public/build/target.common.tests.zip into memory 14:41:12 INFO - Expected file size: 20256464 14:41:12 INFO - Obtained file size: 20256464 14:41:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EcywXawJSIuho9G_imj5qg/artifacts/public/build/target.talos.tests.zip 14:41:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EcywXawJSIuho9G_imj5qg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 14:41:17 INFO - Fetch https://queue.taskcluster.net/v1/task/EcywXawJSIuho9G_imj5qg/artifacts/public/build/target.talos.tests.zip into memory 14:41:18 INFO - Expected file size: 14403529 14:41:18 INFO - Obtained file size: 14403529 14:41: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')]} 14:41:18 INFO - trying https://queue.taskcluster.net/v1/task/EcywXawJSIuho9G_imj5qg/artifacts/public/build/target.tar.bz2 14:41:18 INFO - Downloading https://queue.taskcluster.net/v1/task/EcywXawJSIuho9G_imj5qg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 14:41:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EcywXawJSIuho9G_imj5qg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 14:41:19 INFO - Downloaded 56061455 bytes. 14:41:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EcywXawJSIuho9G_imj5qg/artifacts/public/build/target.tar.bz2 14:41:19 INFO - mkdir: /builds/slave/test/properties 14:41:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:41:19 INFO - Writing to file /builds/slave/test/properties/build_url 14:41:19 INFO - Contents: 14:41:19 INFO - build_url:https://queue.taskcluster.net/v1/task/EcywXawJSIuho9G_imj5qg/artifacts/public/build/target.tar.bz2 14:41:19 INFO - Running post-action listener: _resource_record_post_action 14:41:19 INFO - Running post-action listener: set_extra_try_arguments 14:41:19 INFO - [mozharness: 2017-01-10 22:41:19.554195Z] Finished download-and-extract step (success) 14:41:19 INFO - [mozharness: 2017-01-10 22:41:19.554290Z] Running populate-webroot step. 14:41:19 INFO - Running pre-action listener: _resource_record_pre_action 14:41:19 INFO - Running main action method: populate_webroot 14:41:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:41:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:41:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:41:19 INFO - '--tppagecycles', 14:41:19 INFO - '7'], 14:41:19 INFO - 'tests': ['tsvgm']}}, 14:41:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:41:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:41:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:41:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:41:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:41:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:41:19 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 14:41:19 INFO - 'talos_options': ['--disable-e10s'], 14:41:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:41:19 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:41:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:41:19 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 14:41:19 INFO - 'talos_options': ['--disable-e10s'], 14:41:19 INFO - 'tests': ['damp', 'tps']}, 14:41:19 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:41:19 INFO - 'tests': ['damp', 'tps']}, 14:41:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:41:19 INFO - 'tests': ['dromaeo_dom']}, 14:41:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:41:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:41:19 INFO - 'tests': ['basic_compositor_video']}, 14:41:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:41:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:41:19 INFO - 'tests': ['a11yr', 14:41:19 INFO - 'ts_paint', 14:41:19 INFO - 'tpaint', 14:41:19 INFO - 'sessionrestore', 14:41:19 INFO - 'sessionrestore_no_auto_restore', 14:41:19 INFO - 'tabpaint']}, 14:41:19 INFO - 'other-e10s': {'tests': ['a11yr', 14:41:19 INFO - 'ts_paint', 14:41:19 INFO - 'tpaint', 14:41:19 INFO - 'sessionrestore', 14:41:19 INFO - 'sessionrestore_no_auto_restore', 14:41:19 INFO - 'tabpaint']}, 14:41:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:41:19 INFO - 'ts_paint', 14:41:19 INFO - 'tpaint', 14:41:19 INFO - 'sessionrestore', 14:41:19 INFO - 'sessionrestore_no_auto_restore', 14:41:19 INFO - 'tabpaint']}, 14:41:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:41:19 INFO - 'ts_paint', 14:41:19 INFO - 'tpaint', 14:41:19 INFO - 'sessionrestore', 14:41:19 INFO - 'sessionrestore_no_auto_restore', 14:41:19 INFO - 'tabpaint']}, 14:41:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:41:19 INFO - 'tests': ['a11yr', 14:41:19 INFO - 'ts_paint', 14:41:19 INFO - 'tpaint', 14:41:19 INFO - 'sessionrestore', 14:41:19 INFO - 'sessionrestore_no_auto_restore', 14:41:19 INFO - 'tabpaint']}, 14:41:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:41:19 INFO - 'tests': ['a11yr', 14:41:19 INFO - 'ts_paint', 14:41:19 INFO - 'tpaint', 14:41:19 INFO - 'sessionrestore', 14:41:19 INFO - 'sessionrestore_no_auto_restore', 14:41:19 INFO - 'tabpaint']}, 14:41:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:41:19 INFO - 'tests': ['tsvgx', 14:41:19 INFO - 'tsvgr_opacity', 14:41:19 INFO - 'tart', 14:41:19 INFO - 'tscrollx', 14:41:19 INFO - 'cart', 14:41:19 INFO - 'tsvg_static']}, 14:41:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:41:19 INFO - 'tsvgr_opacity', 14:41:19 INFO - 'tart', 14:41:19 INFO - 'tscrollx', 14:41:19 INFO - 'cart', 14:41:19 INFO - 'tsvg_static']}, 14:41:19 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 14:41:19 INFO - 'talos_options': ['--disable-e10s'], 14:41:19 INFO - 'tests': ['tp5o']}, 14:41:19 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:41:19 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 14:41:19 INFO - 'talos_options': ['--disable-e10s', 14:41:19 INFO - '--xperf_path', 14:41:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:41:19 INFO - 'tests': ['tp5n']}, 14:41:19 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:41:19 INFO - 'talos_options': ['--xperf_path', 14:41:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:41:19 INFO - 'tests': ['tp5n']}}, 14:41:19 INFO - 'talos.zip': {'path': '', 14:41:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:41:19 INFO - Running post-action listener: _resource_record_post_action 14:41:19 INFO - [mozharness: 2017-01-10 22:41:19.567234Z] Finished populate-webroot step (success) 14:41:19 INFO - [mozharness: 2017-01-10 22:41:19.567326Z] Running create-virtualenv step. 14:41:19 INFO - Running pre-action listener: _resource_record_pre_action 14:41:19 INFO - Running main action method: create_virtualenv 14:41:19 INFO - Creating virtualenv /builds/slave/test/build/venv 14:41:19 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 14:41:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:41:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:41:19 INFO - Using real prefix '/usr' 14:41:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:41:20 INFO - Installing distribute.............................................................................................................................................................................................done. 14:41:22 INFO - Installing pip.................done. 14:41:22 INFO - Return code: 0 14:41:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:41:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:41:22 INFO - Reading from file tmpfile_stdout 14:41:22 INFO - Output received: 14:41:22 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) 14:41:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:41: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')]} 14:41:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:41:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41: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')]} 14:41:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:41:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:22 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 0xe7e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1279850>, '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 0x11ee6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11eeb60>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1484088062.801529-1647687941', '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 14:41:22 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 14:41:22 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 14:41:22 INFO - Using env: {'DISPLAY': ':0', 14:41:22 INFO - 'HOME': '/home/cltbld', 14:41:22 INFO - 'LANG': 'en_US.UTF-8', 14:41:22 INFO - 'LANGUAGE': 'en_US:en', 14:41:22 INFO - 'LOGNAME': 'cltbld', 14:41:22 INFO - 'MAIL': '/var/mail/cltbld', 14:41:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:41:22 INFO - 'MOZ_NO_REMOTE': '1', 14:41:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:41:22 INFO - 'NO_EM_RESTART': '1', 14:41:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:41:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:41:22 INFO - 'PWD': '/builds/slave/test', 14:41:22 INFO - 'SHELL': '/bin/bash', 14:41:22 INFO - 'SHLVL': '1', 14:41:22 INFO - 'TERM': 'linux', 14:41:22 INFO - 'TMOUT': '86400', 14:41:22 INFO - 'USER': 'cltbld', 14:41:22 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1484088062.801529-1647687941', 14:41:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:41:22 INFO - '_': '/tools/buildbot/bin/python'} 14:41:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:41:22 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 14:41:22 INFO - Cleaning up... 14:41:22 INFO - Return code: 0 14:41:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:41: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')]} 14:41:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:41:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41: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')]} 14:41:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:41:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:22 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 0xe7e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1279850>, '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 0x11ee6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11eeb60>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1484088062.801529-1647687941', '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 14:41:22 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 14:41:22 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 14:41:22 INFO - Using env: {'DISPLAY': ':0', 14:41:22 INFO - 'HOME': '/home/cltbld', 14:41:22 INFO - 'LANG': 'en_US.UTF-8', 14:41:22 INFO - 'LANGUAGE': 'en_US:en', 14:41:22 INFO - 'LOGNAME': 'cltbld', 14:41:22 INFO - 'MAIL': '/var/mail/cltbld', 14:41:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:41:22 INFO - 'MOZ_NO_REMOTE': '1', 14:41:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:41:22 INFO - 'NO_EM_RESTART': '1', 14:41:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:41:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:41:22 INFO - 'PWD': '/builds/slave/test', 14:41:22 INFO - 'SHELL': '/bin/bash', 14:41:22 INFO - 'SHLVL': '1', 14:41:22 INFO - 'TERM': 'linux', 14:41:22 INFO - 'TMOUT': '86400', 14:41:22 INFO - 'USER': 'cltbld', 14:41:22 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1484088062.801529-1647687941', 14:41:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:41:22 INFO - '_': '/tools/buildbot/bin/python'} 14:41:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:41:22 INFO - Downloading/unpacking psutil>=3.1.1 14:41:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:41:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:41:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:41:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:41:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:41:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:41:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:41:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:41:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:41:24 INFO - Installing collected packages: psutil 14:41:24 INFO - Running setup.py install for psutil 14:41:24 INFO - building 'psutil._psutil_linux' extension 14:41:24 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 14:41:25 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 14:41:25 INFO - building 'psutil._psutil_posix' extension 14:41:25 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 14:41:25 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 14:41:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:41:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:41:25 INFO - Successfully installed psutil 14:41:25 INFO - Cleaning up... 14:41:25 INFO - Return code: 0 14:41:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:41: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')]} 14:41:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:41:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41: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')]} 14:41:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:41:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:25 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 0xe7e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1279850>, '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 0x11ee6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11eeb60>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1484088062.801529-1647687941', '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 14:41:25 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 14:41:25 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 14:41:25 INFO - Using env: {'DISPLAY': ':0', 14:41:25 INFO - 'HOME': '/home/cltbld', 14:41:25 INFO - 'LANG': 'en_US.UTF-8', 14:41:25 INFO - 'LANGUAGE': 'en_US:en', 14:41:25 INFO - 'LOGNAME': 'cltbld', 14:41:25 INFO - 'MAIL': '/var/mail/cltbld', 14:41:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:41:25 INFO - 'MOZ_NO_REMOTE': '1', 14:41:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:41:25 INFO - 'NO_EM_RESTART': '1', 14:41:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:41:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:41:25 INFO - 'PWD': '/builds/slave/test', 14:41:25 INFO - 'SHELL': '/bin/bash', 14:41:25 INFO - 'SHLVL': '1', 14:41:25 INFO - 'TERM': 'linux', 14:41:25 INFO - 'TMOUT': '86400', 14:41:25 INFO - 'USER': 'cltbld', 14:41:25 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1484088062.801529-1647687941', 14:41:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:41:25 INFO - '_': '/tools/buildbot/bin/python'} 14:41:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:41:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:41:25 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 14:41:25 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 14:41:25 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 14:41:25 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 14:41:25 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 14:41:25 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 14:41:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:41:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:41:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:41:27 INFO - Installing collected packages: mozsystemmonitor 14:41:27 INFO - Running setup.py install for mozsystemmonitor 14:41:28 INFO - Successfully installed mozsystemmonitor 14:41:28 INFO - Cleaning up... 14:41:28 INFO - Return code: 0 14:41:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:41:28 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')]} 14:41:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:41:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:28 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')]} 14:41:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:41:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:28 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 0xe7e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1279850>, '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 0x11ee6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11eeb60>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1484088062.801529-1647687941', '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 14:41:28 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 14:41:28 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 14:41:28 INFO - Using env: {'DISPLAY': ':0', 14:41:28 INFO - 'HOME': '/home/cltbld', 14:41:28 INFO - 'LANG': 'en_US.UTF-8', 14:41:28 INFO - 'LANGUAGE': 'en_US:en', 14:41:28 INFO - 'LOGNAME': 'cltbld', 14:41:28 INFO - 'MAIL': '/var/mail/cltbld', 14:41:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:41:28 INFO - 'MOZ_NO_REMOTE': '1', 14:41:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:41:28 INFO - 'NO_EM_RESTART': '1', 14:41:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:41:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:41:28 INFO - 'PWD': '/builds/slave/test', 14:41:28 INFO - 'SHELL': '/bin/bash', 14:41:28 INFO - 'SHLVL': '1', 14:41:28 INFO - 'TERM': 'linux', 14:41:28 INFO - 'TMOUT': '86400', 14:41:28 INFO - 'USER': 'cltbld', 14:41:28 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1484088062.801529-1647687941', 14:41:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:41:28 INFO - '_': '/tools/buildbot/bin/python'} 14:41:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:41:28 INFO - Downloading/unpacking jsonschema==2.5.1 14:41:28 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 14:41:28 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 14:41:28 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 14:41:28 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 14:41:28 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 14:41:28 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 14:41:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:41:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:41:30 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 14:41:30 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 14:41:30 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 14:41:30 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 14:41:30 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 14:41:30 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 14:41:30 INFO - Downloading functools32-3.2.3-2.tar.gz 14:41:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:41:30 INFO - warning: no files found matching '*.txt' 14:41:30 INFO - no previously-included directories found matching 'build' 14:41:30 INFO - no previously-included directories found matching 'dist' 14:41:30 INFO - no previously-included directories found matching '.git*' 14:41:30 INFO - Installing collected packages: jsonschema, functools32 14:41:30 INFO - Running setup.py install for functools32 14:41:30 INFO - warning: no files found matching '*.txt' 14:41:30 INFO - no previously-included directories found matching 'build' 14:41:30 INFO - no previously-included directories found matching 'dist' 14:41:30 INFO - no previously-included directories found matching '.git*' 14:41:30 INFO - Successfully installed jsonschema functools32 14:41:30 INFO - Cleaning up... 14:41:30 INFO - Return code: 0 14:41:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:41: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')]} 14:41:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:41:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41: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')]} 14:41:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:41:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41: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', '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 0xe7e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1279850>, '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 0x11ee6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11eeb60>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1484088062.801529-1647687941', '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 14:41: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:41: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 functools32==3.2.3-2 14:41:30 INFO - Using env: {'DISPLAY': ':0', 14:41:30 INFO - 'HOME': '/home/cltbld', 14:41:30 INFO - 'LANG': 'en_US.UTF-8', 14:41:30 INFO - 'LANGUAGE': 'en_US:en', 14:41:30 INFO - 'LOGNAME': 'cltbld', 14:41:30 INFO - 'MAIL': '/var/mail/cltbld', 14:41:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:41:30 INFO - 'MOZ_NO_REMOTE': '1', 14:41:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:41:30 INFO - 'NO_EM_RESTART': '1', 14:41:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:41:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:41:30 INFO - 'PWD': '/builds/slave/test', 14:41:30 INFO - 'SHELL': '/bin/bash', 14:41:30 INFO - 'SHLVL': '1', 14:41:30 INFO - 'TERM': 'linux', 14:41:30 INFO - 'TMOUT': '86400', 14:41:30 INFO - 'USER': 'cltbld', 14:41:30 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1484088062.801529-1647687941', 14:41:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:41:30 INFO - '_': '/tools/buildbot/bin/python'} 14:41:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:41:31 INFO - Cleaning up... 14:41:31 INFO - Return code: 0 14:41:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:41:31 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')]} 14:41:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:41:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:31 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')]} 14:41:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:41:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:31 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 0xe7e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1279850>, '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 0x11ee6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11eeb60>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1484088062.801529-1647687941', '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 14:41:31 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 14:41:31 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 14:41:31 INFO - Using env: {'DISPLAY': ':0', 14:41:31 INFO - 'HOME': '/home/cltbld', 14:41:31 INFO - 'LANG': 'en_US.UTF-8', 14:41:31 INFO - 'LANGUAGE': 'en_US:en', 14:41:31 INFO - 'LOGNAME': 'cltbld', 14:41:31 INFO - 'MAIL': '/var/mail/cltbld', 14:41:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:41:31 INFO - 'MOZ_NO_REMOTE': '1', 14:41:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:41:31 INFO - 'NO_EM_RESTART': '1', 14:41:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:41:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:41:31 INFO - 'PWD': '/builds/slave/test', 14:41:31 INFO - 'SHELL': '/bin/bash', 14:41:31 INFO - 'SHLVL': '1', 14:41:31 INFO - 'TERM': 'linux', 14:41:31 INFO - 'TMOUT': '86400', 14:41:31 INFO - 'USER': 'cltbld', 14:41:31 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1484088062.801529-1647687941', 14:41:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:41:31 INFO - '_': '/tools/buildbot/bin/python'} 14:41:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:41:31 INFO - Downloading/unpacking blobuploader==1.2.4 14:41:31 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 14:41:31 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 14:41:31 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 14:41:31 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 14:41:31 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 14:41:31 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 14:41:33 INFO - Downloading blobuploader-1.2.4.tar.gz 14:41:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:41:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:41:33 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 14:41:33 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 14:41:33 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 14:41:33 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 14:41:33 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 14:41:33 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 14:41:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:41:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:41:33 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 14:41:33 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 14:41:33 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 14:41:33 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 14:41:33 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 14:41:33 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 14:41:33 INFO - Downloading docopt-0.6.1.tar.gz 14:41:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:41:34 INFO - Installing collected packages: blobuploader, requests, docopt 14:41:34 INFO - Running setup.py install for blobuploader 14:41:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:41:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:41:34 INFO - Running setup.py install for requests 14:41:34 INFO - Running setup.py install for docopt 14:41:34 INFO - Successfully installed blobuploader requests docopt 14:41:34 INFO - Cleaning up... 14:41:34 INFO - Return code: 0 14:41:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:41:34 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')]} 14:41:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:41:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:34 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')]} 14:41:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:41:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:34 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 0xe7e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1279850>, '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 0x11ee6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11eeb60>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1484088062.801529-1647687941', '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 14:41:34 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 14:41:34 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 14:41:34 INFO - Using env: {'DISPLAY': ':0', 14:41:34 INFO - 'HOME': '/home/cltbld', 14:41:34 INFO - 'LANG': 'en_US.UTF-8', 14:41:34 INFO - 'LANGUAGE': 'en_US:en', 14:41:34 INFO - 'LOGNAME': 'cltbld', 14:41:34 INFO - 'MAIL': '/var/mail/cltbld', 14:41:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:41:34 INFO - 'MOZ_NO_REMOTE': '1', 14:41:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:41:34 INFO - 'NO_EM_RESTART': '1', 14:41:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:41:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:41:34 INFO - 'PWD': '/builds/slave/test', 14:41:34 INFO - 'SHELL': '/bin/bash', 14:41:34 INFO - 'SHLVL': '1', 14:41:34 INFO - 'TERM': 'linux', 14:41:34 INFO - 'TMOUT': '86400', 14:41:34 INFO - 'USER': 'cltbld', 14:41:34 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1484088062.801529-1647687941', 14:41:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:41:34 INFO - '_': '/tools/buildbot/bin/python'} 14:41:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:41:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:41:34 INFO - Running setup.py (path:/tmp/pip-4PgV9M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:41:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:41:34 INFO - Running setup.py (path:/tmp/pip-VYzUtI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:41:35 INFO - Running setup.py (path:/tmp/pip-BYSz36-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:41:35 INFO - Running setup.py (path:/tmp/pip-LyDYLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:41:35 INFO - Running setup.py (path:/tmp/pip-8JQ_fS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:41:35 INFO - Running setup.py (path:/tmp/pip-ZFaY4d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:41:35 INFO - Running setup.py (path:/tmp/pip-RIph2w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:41:35 INFO - Running setup.py (path:/tmp/pip-z1LZ7p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:41:35 INFO - Running setup.py (path:/tmp/pip-bUrHxx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:41:35 INFO - Running setup.py (path:/tmp/pip-n1Mk9t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:41:35 INFO - Running setup.py (path:/tmp/pip-14sHEN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:41:35 INFO - Running setup.py (path:/tmp/pip-MRq8UK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:41:35 INFO - Running setup.py (path:/tmp/pip-wH2YS5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:41:35 INFO - Running setup.py (path:/tmp/pip-PlwRyk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:41:35 INFO - Running setup.py (path:/tmp/pip-dEMwhW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:41:35 INFO - Running setup.py (path:/tmp/pip-oBMVvL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:41:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:41:36 INFO - Running setup.py (path:/tmp/pip-mBSdC_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:41:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:41:36 INFO - Running setup.py install for manifestparser 14:41:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:41:36 INFO - Running setup.py install for mozcrash 14:41:36 INFO - Running setup.py install for mozdebug 14:41:36 INFO - Running setup.py install for mozdevice 14:41:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:41:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:41:36 INFO - Running setup.py install for mozfile 14:41:36 INFO - Running setup.py install for mozhttpd 14:41:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:41:36 INFO - Running setup.py install for mozinfo 14:41:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:41:36 INFO - Running setup.py install for mozInstall 14:41:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:41:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:41:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:41:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:41:36 INFO - Running setup.py install for mozleak 14:41:36 INFO - Running setup.py install for mozlog 14:41:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:41:37 INFO - Running setup.py install for moznetwork 14:41:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:41:37 INFO - Running setup.py install for mozprocess 14:41:37 INFO - Running setup.py install for mozprofile 14:41:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:41:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:41:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:41:37 INFO - Running setup.py install for mozrunner 14:41:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:41:37 INFO - Running setup.py install for mozscreenshot 14:41:37 INFO - Running setup.py install for moztest 14:41:37 INFO - Running setup.py install for mozversion 14:41:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:41:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:41:37 INFO - Cleaning up... 14:41:37 INFO - Return code: 0 14:41:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:41:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:41:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:41:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:41:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:41:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:37 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 0xe7e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1279850>, '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 0x11ee6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11eeb60>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1484088062.801529-1647687941', '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 14:41:37 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 14:41:37 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 14:41:37 INFO - Using env: {'DISPLAY': ':0', 14:41:37 INFO - 'HOME': '/home/cltbld', 14:41:37 INFO - 'LANG': 'en_US.UTF-8', 14:41:37 INFO - 'LANGUAGE': 'en_US:en', 14:41:37 INFO - 'LOGNAME': 'cltbld', 14:41:37 INFO - 'MAIL': '/var/mail/cltbld', 14:41:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:41:37 INFO - 'MOZ_NO_REMOTE': '1', 14:41:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:41:37 INFO - 'NO_EM_RESTART': '1', 14:41:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:41:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:41:37 INFO - 'PWD': '/builds/slave/test', 14:41:37 INFO - 'SHELL': '/bin/bash', 14:41:37 INFO - 'SHLVL': '1', 14:41:37 INFO - 'TERM': 'linux', 14:41:37 INFO - 'TMOUT': '86400', 14:41:37 INFO - 'USER': 'cltbld', 14:41:37 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1484088062.801529-1647687941', 14:41:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:41:37 INFO - '_': '/tools/buildbot/bin/python'} 14:41:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:41:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:41:38 INFO - Running setup.py (path:/tmp/pip-DNlAT_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:41:38 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)) 14:41:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:41:38 INFO - Running setup.py (path:/tmp/pip-L_YGwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:41:38 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)) 14:41:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:41:38 INFO - Running setup.py (path:/tmp/pip-R0VF82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:41:38 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)) 14:41:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:41:38 INFO - Running setup.py (path:/tmp/pip-6gkMDi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:41:38 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)) 14:41:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:41:38 INFO - Running setup.py (path:/tmp/pip-P_qSbj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:41:38 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)) 14:41:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:41:38 INFO - Running setup.py (path:/tmp/pip-s0R5zx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:41:38 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)) 14:41:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:41:38 INFO - Running setup.py (path:/tmp/pip-Vnzvaa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:41:38 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)) 14:41:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:41:38 INFO - Running setup.py (path:/tmp/pip-3cly4_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:41:38 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)) 14:41:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:41:38 INFO - Running setup.py (path:/tmp/pip-BG3PGW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:41:38 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)) 14:41:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:41:38 INFO - Running setup.py (path:/tmp/pip-c0Keaf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:41:38 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)) 14:41:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:41:38 INFO - Running setup.py (path:/tmp/pip-8_6NmH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:41:38 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)) 14:41:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:41:38 INFO - Running setup.py (path:/tmp/pip-CcOk0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:41:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:41:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:41:39 INFO - Running setup.py (path:/tmp/pip-SBZj0o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:41:39 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)) 14:41:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:41:39 INFO - Running setup.py (path:/tmp/pip-mt3NJJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:41:39 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)) 14:41:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:41:39 INFO - Running setup.py (path:/tmp/pip-ayUb_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:41:39 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)) 14:41:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:41:39 INFO - Running setup.py (path:/tmp/pip-7nJyo2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:41:39 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)) 14:41:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:41:39 INFO - Running setup.py (path:/tmp/pip-5vpkug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:41:39 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)) 14:41:39 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)) 14:41:39 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)) 14:41:39 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)) 14:41:39 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)) 14:41:39 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)) 14:41:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:41:39 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 14:41:39 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 14:41:39 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 14:41:39 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 14:41:39 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 14:41:39 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 14:41:41 INFO - Downloading blessings-1.6.tar.gz 14:41:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:41:41 INFO - Installing collected packages: blessings 14:41:41 INFO - Running setup.py install for blessings 14:41:41 INFO - Successfully installed blessings 14:41:41 INFO - Cleaning up... 14:41:41 INFO - Return code: 0 14:41:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:41:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:41:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:41:41 INFO - Reading from file tmpfile_stdout 14:41:41 INFO - Current package versions: 14:41:41 INFO - argparse == 1.2.1 14:41:41 INFO - blessings == 1.6 14:41:41 INFO - blobuploader == 1.2.4 14:41:41 INFO - docopt == 0.6.1 14:41:41 INFO - functools32 == 3.2.3-2 14:41:41 INFO - jsonschema == 2.5.1 14:41:41 INFO - manifestparser == 1.1 14:41:41 INFO - mozInstall == 1.12 14:41:41 INFO - mozcrash == 1.0 14:41:41 INFO - mozdebug == 0.1 14:41:41 INFO - mozdevice == 0.49 14:41:41 INFO - mozfile == 1.2 14:41:41 INFO - mozhttpd == 0.7 14:41:41 INFO - mozinfo == 0.9 14:41:41 INFO - mozleak == 0.1 14:41:41 INFO - mozlog == 3.4 14:41:41 INFO - moznetwork == 0.27 14:41:41 INFO - mozprocess == 0.24 14:41:41 INFO - mozprofile == 0.28 14:41:41 INFO - mozrunner == 6.13 14:41:41 INFO - mozscreenshot == 0.1 14:41:41 INFO - mozsystemmonitor == 0.3 14:41:41 INFO - moztest == 0.8 14:41:41 INFO - mozversion == 1.4 14:41:41 INFO - psutil == 3.1.1 14:41:41 INFO - requests == 1.2.3 14:41:41 INFO - wsgiref == 0.1.2 14:41:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:41:41 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')]} 14:41:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:41:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:41 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')]} 14:41:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:41:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:41 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 0xe7e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1279850>, '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 0x11ee6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11eeb60>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1484088062.801529-1647687941', '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 14:41:41 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 14:41:41 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 14:41:41 INFO - Using env: {'DISPLAY': ':0', 14:41:41 INFO - 'HOME': '/home/cltbld', 14:41:41 INFO - 'LANG': 'en_US.UTF-8', 14:41:41 INFO - 'LANGUAGE': 'en_US:en', 14:41:41 INFO - 'LOGNAME': 'cltbld', 14:41:41 INFO - 'MAIL': '/var/mail/cltbld', 14:41:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:41:41 INFO - 'MOZ_NO_REMOTE': '1', 14:41:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:41:41 INFO - 'NO_EM_RESTART': '1', 14:41:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:41:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:41:41 INFO - 'PWD': '/builds/slave/test', 14:41:41 INFO - 'SHELL': '/bin/bash', 14:41:41 INFO - 'SHLVL': '1', 14:41:41 INFO - 'TERM': 'linux', 14:41:41 INFO - 'TMOUT': '86400', 14:41:41 INFO - 'USER': 'cltbld', 14:41:41 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1484088062.801529-1647687941', 14:41:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:41:41 INFO - '_': '/tools/buildbot/bin/python'} 14:41:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:41:42 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)) 14:41:42 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)) 14:41:42 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)) 14:41:42 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)) 14:41:42 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)) 14:41:42 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)) 14:41:42 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)) 14:41:42 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)) 14:41:42 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)) 14:41:42 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)) 14:41:42 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)) 14:41:42 INFO - Cleaning up... 14:41:42 INFO - Return code: 0 14:41:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:41: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')]} 14:41:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:41:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41: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')]} 14:41:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:41:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:42 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 0xe7e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1279850>, '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 0x11ee6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11eeb60>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1484088062.801529-1647687941', '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 14:41:42 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 14:41:42 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 14:41:42 INFO - Using env: {'DISPLAY': ':0', 14:41:42 INFO - 'HOME': '/home/cltbld', 14:41:42 INFO - 'LANG': 'en_US.UTF-8', 14:41:42 INFO - 'LANGUAGE': 'en_US:en', 14:41:42 INFO - 'LOGNAME': 'cltbld', 14:41:42 INFO - 'MAIL': '/var/mail/cltbld', 14:41:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:41:42 INFO - 'MOZ_NO_REMOTE': '1', 14:41:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:41:42 INFO - 'NO_EM_RESTART': '1', 14:41:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:41:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:41:42 INFO - 'PWD': '/builds/slave/test', 14:41:42 INFO - 'SHELL': '/bin/bash', 14:41:42 INFO - 'SHLVL': '1', 14:41:42 INFO - 'TERM': 'linux', 14:41:42 INFO - 'TMOUT': '86400', 14:41:42 INFO - 'USER': 'cltbld', 14:41:42 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1484088062.801529-1647687941', 14:41:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:41:42 INFO - '_': '/tools/buildbot/bin/python'} 14:41:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:41:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:41:42 INFO - Cleaning up... 14:41:42 INFO - Return code: 0 14:41:42 INFO - Running post-action listener: _resource_record_post_action 14:41:42 INFO - Running post-action listener: _start_resource_monitoring 14:41:42 INFO - Starting resource monitoring. 14:41:42 INFO - [mozharness: 2017-01-10 22:41:42.356634Z] Finished create-virtualenv step (success) 14:41:42 INFO - [mozharness: 2017-01-10 22:41:42.357140Z] Running install step. 14:41:42 INFO - Running pre-action listener: _resource_record_pre_action 14:41:42 INFO - Running main action method: install 14:41:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:41:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:41:42 INFO - Reading from file tmpfile_stdout 14:41:42 INFO - Detecting whether we're running mozinstall >=1.0... 14:41:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:41:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:41:42 INFO - Reading from file tmpfile_stdout 14:41:42 INFO - Output received: 14:41:42 INFO - Usage: mozinstall [options] installer 14:41:42 INFO - Options: 14:41:42 INFO - -h, --help show this help message and exit 14:41:42 INFO - -d DEST, --destination=DEST 14:41:42 INFO - Directory to install application into. [default: 14:41:42 INFO - "/builds/slave/test"] 14:41:42 INFO - --app=APP Application being installed. [default: firefox] 14:41:42 INFO - mkdir: /builds/slave/test/build/application 14:41:42 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'] 14:41:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 14:41:58 INFO - Reading from file tmpfile_stdout 14:41:58 INFO - Output received: 14:41:58 INFO - /builds/slave/test/build/application/firefox/firefox 14:41:58 INFO - Running post-action listener: _resource_record_post_action 14:41:58 INFO - [mozharness: 2017-01-10 22:41:58.780905Z] Finished install step (success) 14:41:58 INFO - [mozharness: 2017-01-10 22:41:58.781180Z] Running run-tests step. 14:41:58 INFO - Running pre-action listener: _resource_record_pre_action 14:41:58 INFO - Running main action method: run_tests 14:41:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:41:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:41:58 INFO - Python 2.7.3 14:41:58 INFO - Return code: 0 14:41:58 INFO - grabbing minidump binary from tooltool 14:41:58 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')]} 14:41:58 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 0x1279850>, '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 0x11ee6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11eeb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:41:58 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 14:41:58 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 14:41:58 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 14:41:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:41:58 INFO - Return code: 0 14:41:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:41:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:41:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:41:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:41:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:41:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EcywXawJSIuho9G_imj5qg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 14:41:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EcywXawJSIuho9G_imj5qg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-063 --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 14:41:58 INFO - Using env: {'DISPLAY': ':0', 14:41:58 INFO - 'HOME': '/home/cltbld', 14:41:58 INFO - 'LANG': 'en_US.UTF-8', 14:41:58 INFO - 'LANGUAGE': 'en_US:en', 14:41:58 INFO - 'LOGNAME': 'cltbld', 14:41:58 INFO - 'MAIL': '/var/mail/cltbld', 14:41:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:41:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:41:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:41:58 INFO - 'MOZ_NO_REMOTE': '1', 14:41:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:41:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:41:58 INFO - 'NO_EM_RESTART': '1', 14:41:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:41:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:41:58 INFO - 'PWD': '/builds/slave/test', 14:41:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:41:58 INFO - 'SHELL': '/bin/bash', 14:41:58 INFO - 'SHLVL': '1', 14:41:58 INFO - 'TERM': 'linux', 14:41:58 INFO - 'TMOUT': '86400', 14:41:58 INFO - 'USER': 'cltbld', 14:41:58 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1484088062.801529-1647687941', 14:41:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:41:58 INFO - '_': '/tools/buildbot/bin/python'} 14:41:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EcywXawJSIuho9G_imj5qg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 14:41:59 INFO - mozversion application_buildid: 20170110215253 14:41:59 INFO - mozversion application_changeset: 20094311ab5ec56d5be7afc6d5c2e2b09e656fb2 14:41:59 INFO - mozversion application_display_name: Nightly 14:41:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:41:59 INFO - mozversion application_name: Firefox 14:41:59 INFO - mozversion application_remotingname: firefox 14:41:59 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:41:59 INFO - mozversion application_vendor: Mozilla 14:41:59 INFO - mozversion application_version: 53.0a1 14:41:59 INFO - mozversion platform_buildid: 20170110215253 14:41:59 INFO - mozversion platform_changeset: 20094311ab5ec56d5be7afc6d5c2e2b09e656fb2 14:41:59 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:41:59 INFO - mozversion platform_version: 53.0a1 14:41:59 INFO - using testdate: 1484088119 14:41:59 INFO - actual date: 1484088119 14:41:59 INFO - starting webserver on 'localhost:54918' 14:41:59 INFO - SUITE-START | Running 2 tests 14:41:59 INFO - TEST-START | dromaeo_css 14:41:59 INFO - operating with platform_type : linux_ 14:41:59 INFO - Initialising browser for dromaeo_css test... 14:41:59 INFO - TEST-INFO | started process 8600 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWcqR6R/profile http://localhost:54918/getInfo.html) 14:42:03 INFO - PROCESS | 8600 | __metrics Screen width/height:1600/1200 14:42:03 INFO - PROCESS | 8600 | colorDepth:24 14:42:03 INFO - PROCESS | 8600 | Browser inner width/height: 1024/697 14:42:03 INFO - PROCESS | 8600 | __metrics 14:42:03 INFO - PROCESS | 8600 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:42:03 INFO - PROCESS | 8600 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:42:04 INFO - PROCESS | 8600 | console.error: PushService: 14:42:04 INFO - PROCESS | 8600 | stateChangeProcessEnqueue: Error transitioning state 14:42:04 INFO - PROCESS | 8600 | UnknownError 14:42:05 INFO - TEST-INFO | 8600: exit 0 14:42:05 INFO - Browser initialized. 14:42:05 INFO - Running cycle 1/1 for dromaeo_css test... 14:42:05 INFO - TEST-INFO | started process 8684 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWcqR6R/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:42:16 INFO - PROCESS | 8684 | RSS: Main: 151621632 14:42:16 INFO - PROCESS | 8684 | 14:45:23 INFO - PROCESS | 8684 | Cycle 1(1): loaded http://localhost:54918/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54918/tests/dromaeo/cssquery-ext.html) 14:45:24 INFO - PROCESS | 8684 | RSS: Main: 267259904 14:45:24 INFO - PROCESS | 8684 | 14:47:06 INFO - PROCESS | 8684 | ************************* 14:47:06 INFO - PROCESS | 8684 | A coding exception was thrown and uncaught in a Task. 14:47:06 INFO - PROCESS | 8684 | 14:47:06 INFO - PROCESS | 8684 | Full message: ReferenceError: fetch is not defined 14:47:06 INFO - PROCESS | 8684 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 14:47:06 INFO - PROCESS | 8684 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 14:47:06 INFO - PROCESS | 8684 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 14:47:06 INFO - PROCESS | 8684 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 14:47:06 INFO - PROCESS | 8684 | TaskImpl@resource://gre/modules/Task.jsm:277:3 14:47:06 INFO - PROCESS | 8684 | asyncFunction@resource://gre/modules/Task.jsm:252:14 14:47:06 INFO - PROCESS | 8684 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 14:47:06 INFO - PROCESS | 8684 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 14:47:06 INFO - PROCESS | 8684 | TaskImpl@resource://gre/modules/Task.jsm:277:3 14:47:06 INFO - PROCESS | 8684 | asyncFunction@resource://gre/modules/Task.jsm:252:14 14:47:06 INFO - PROCESS | 8684 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 14:47:06 INFO - PROCESS | 8684 | 14:47:06 INFO - PROCESS | 8684 | ************************* 14:48:27 INFO - PROCESS | 8684 | Cycle 1(1): loaded http://localhost:54918/tests/dromaeo/cssquery-ext.html (next: http://localhost:54918/tests/dromaeo/cssquery-jquery.html) 14:48:27 INFO - PROCESS | 8684 | RSS: Main: 243740672 14:48:27 INFO - PROCESS | 8684 | 14:51:30 INFO - PROCESS | 8684 | Cycle 1(1): loaded http://localhost:54918/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54918/tests/dromaeo/cssquery-mootools.html) 14:51:30 INFO - PROCESS | 8684 | RSS: Main: 225992704 14:51:30 INFO - PROCESS | 8684 | 14:54:32 INFO - PROCESS | 8684 | Cycle 1(1): loaded http://localhost:54918/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54918/tests/dromaeo/cssquery-prototype.html) 14:54:33 INFO - PROCESS | 8684 | RSS: Main: 185073664 14:54:33 INFO - PROCESS | 8684 | 14:57:36 INFO - PROCESS | 8684 | Cycle 1(1): loaded http://localhost:54918/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54918/tests/dromaeo/cssquery-yui.html) 14:57:37 INFO - PROCESS | 8684 | RSS: Main: 185581568 14:57:37 INFO - PROCESS | 8684 | 15:00:40 INFO - PROCESS | 8684 | Cycle 1(1): loaded http://localhost:54918/tests/dromaeo/cssquery-yui.html (next: http://localhost:54918/tests/dromaeo/cssquery-dojo.html) 15:00:40 INFO - PROCESS | 8684 | RSS: Main: 275144704 15:00:40 INFO - PROCESS | 8684 | 15:00:40 INFO - PROCESS | 8684 | __start_tp_report 15:00:40 INFO - PROCESS | 8684 | _x_x_mozilla_page_load 15:00:40 INFO - PROCESS | 8684 | _x_x_mozilla_page_load_details 15:00:40 INFO - PROCESS | 8684 | |i|pagename|runs| 15:00:40 INFO - PROCESS | 8684 | |0;dojo.html;2608.3087981684853;2633.354828067124;2655.601659751038;2664.0276299150805;2665.5068812269733;4761.761911904408;4789.928151077736;4835.153848076586;4928.802847886085;4955.52922472365;4876.292937524066;4879.268109783534;4902.509749025105;4947.7031378117335;4996.825111121111;4388.67084968627;4415.094905544372;4455.353973673816;4491.554619121554;4502.144592527409;4059.4925634295714;4464.776761161945;4518.774061296938;4552.248878934988;4597.379353787246;4388.802503887333;4457.888552786207;4464.6428285737065;4483.955160448402;4562.84030058948;4400.867973960786;4451.910961780746;4455.732656040648;4459.019015816515;4463.464384273875;4421.823127074913;4437.423134992463;4442.977785111054;4444.488883778375;4445.533219012022;4809.567138957475;4855.514448555152;4868.440129385095;4885.60915126789;4892.68197567157;5164.1220992431;5277.788888444457;5277.86805329866;5279.868003299948;5281.313429254173;5244.895102097937;5247;5250.947490525123;5268.078086334876;5279.41926388097;4853.150698627761;4987.925181122286;4989.525995030466;5002.624803139706;5038.496150384932;5168.198929165986;5246.449122842047;5283.128283833124;5467.726613669301;5468.589855760754;5117.71852548106;5122.513361230752;5122.718250496184;5124.487551244845;5126.6923984561045;5148.536631703165;5218.399884013387;5220.243064755589;5231.790728370898;5233.502817232356;5108.438071812097;5116.3348764661105;5120;5122.615803814729;5186.273921650972;5110.642255042186;5113.53978141969;5117.667351622133;5122.9743851281255;5123.103456895028;4355.477342718894;4371.540988196257;4374.650027997753;4374.846880359172;4374.846880359172;3746.456763769238;3800.5439347278502;3809.790461524643;3892.4161375793856;3901.2002539479904;4431.313146462304;4433.7561434121435;4439.489458712224;4473.172463094338;4473.507914129443;5083.567896728746;5173.741312934339;5181;5183.896322073538;5194.039102765925;4405.977970110129;4444.755538445352;4487.708298960557;4502.257127573979;4503.279475284005;4740.928886066712;4742.549457801572;4745.762711864393;4781.9043619128115;4796.37647105874;4925.655204135676;4930.482299358516;4930.728809915561;4933.55597996182;4976.701397916137;5112.846614601568;5114.105031619526;5120.846374608767;5175.81884634036;5259.789608415621;4750.714957102585;4828.61371090319;4845.103655823684;4847.224444088929;4847.709137451764;5095.414027386898;5098.515641014098;5100.6429549931145;5109.029284436094;5110;5128.282040514257;5204.713740744295;5210.583153347648;5249.9737501313775;5267;5097.133487307093;5129.79480820763;5137.614678899023;5140.20326849324;5145.408278048072;4930.6795058321095;4988.4762099980435;4993.700377977333;5102.285680004728;5176.1200595899545;5069.062223488519;5092.668976516515;5101.464346243591;5131.281620573197;5144.897102058013;5150.587952963829;5169.870753231049;5180.6891586504935;5181.844544663666;5226.555742761756;4830;5024.045431368028;5024.924626130538;5028.472010438997;5065.316182315488 15:00:40 INFO - PROCESS | 8684 | |1;ext.html;509.66107538486904;537.1030379266622;543.6357640380944;548.7503186050346;552.0063885006989;28866.278343041435;39005;41004.284507281634;41079.79460102695;46037.30944035842;42617.78691106548;43067.35398969018;43076.784616076955;43218.56781432185;43231.56768432315;7616.885746713804;7728.6088504069385;7923.049234091917;7932;7938.44430889838;7503.212162722917;10006.249531285146;10329.948350258239;10336.89663103367;10699.358038517714;9865.309428340019;9875.753106172331;9923.553440095176;9935.950320248425;9944.453055081967;10328.328658637165;10392.584296628125;10397.792044159074;10409.73975650611;10409.79180416395;10171.54228059739;10238.078572928398;10255.79488410235;10260.281780275383;10268.743281418025;39874.40188397176;40252.59747402518;40253;40290;40304.19391612151;3753.71847111465;3757.28611563802;3778.1121436462686;3786.992893766308;3858;30157.547636785464;30378.69621303781;30541.236469088228;30686.232844178852;31849.203769905707;3323.2522682396266;3424.5548078749603;3489.5986961499243;3528.629493903129;3540.3627347077772;268794;268829;269484;269757;270464;49197.50802492001;49590.25614615784;49610.255846162334;49697.75151124221;49778.25332620014;51929.74035129876;52056.47943520592;52113.47886521162;52289.47710522922;52379.47620523746;12614.369281535886;12768.93615531935;12770.637432075097;12803.551875684307;12806.42371093303;8659;8850.867236991451;9714.417134971924;9754.512274386394;9853.605855765689;16123.516294511184;16688.74966875498;16692.499225023268;16725.832741672428;17052.2326495308;6535.640539770358;6615.933840661628;6765.887691661891;6791.932080679228;6841.247462779091;803.5379656697305;827.5531213144834;828.0436096308773;844.0673056272852;860.9354298427518;28175.859120704674;28465.57301640477;28892.855535722607;29376;29427.558586621217;953.9475328856979;980.1374790184734;991.6677912899115;996.5067291690659;1000.8999100090078;15152.696946061016;15195.772063419057;15349.846501535065;15373.627800585267;15390.384384624489;140255;141150;141338.2933085328;141594;141653;54412.72793636007;54776.17835732467;54930.45069549333;54995;55000.17499737507;1235.3576140406938;1267.1889990406332;1268.879456451654;1283.5186804948144;1285.633594425603;26844.617730124373;27059.1882243533;27403;28260.85869570639;28336.43327133487;47010.29484557803;48476.5152348472;48561;48607;48670.5132948666;347573.71836534835;355659;356525;357578;358218;28948.13155605335;28976.826737995158;31257.218569535944;35497.290054199286;35994.64005359913;34778.478322825686;38014.239715206095;38216.235675286895;38264.80867595644;38478.80760596179;32743.836280818443;32984;33294.33411331808;33361.66638333683;34215.486767699;32579.511307329936;32583.348333033682;32597.674023259464;32831;33042.33915321728;32306.83846580752;32393.676063240007;32498;32512.187195320304;32588.511172332906;25487.490250195264;26284;29060.418791624474;29066.27334316659;29360.853195733886;22264.77735222627;22608.208712694977;22937.311880643607;23048.769512305335;23075 15:00:40 INFO - PROCESS | 8684 | |2;jquery.html;368.1220289609283;382.58489538850347;385.77817754791005;385.96719278861303;402.4024323879039;16355.10516137736;18296.359627413043;18697.065146742643;18791.248350066;18794.060296985164;16922.915385423086;18136.546586335317;18337.44987650369;18534.814651853478;18545.907270463664;5162.845114646567;5296.311479507659;5327.041132596131;5332.466753324676;5336.332958380202;3860.749051311656;4035.61661642145;6284.057391391305;6297.3387794281625;6403.359664033606;6099.756009759604;6327.620342779448;6337.239531256256;6339.492840572743;6340.936590634104;6224.626522408647;6294.653794041325;6297;6309.085182648513;6309.905351419732;4963.305137280783;5172.043172013152;5228.947710522884;5552;5556.138798486241;12463.065270104778;12583.307918064504;15878.126703031328;21230.893845530827;21626.459338516506;2193.9780602193932;2214.258223495131;2221.2447767758877;2246.168917500519;2262.886855657227;9653.951730241373;9957.55191016406;9959.800803983951;10685.091767199798;13577.660558486019;1682.9663406731797;1714.6827836850098;1754.9645709031604;1756.2623698046723;1757.4201908939194;75239;77342;78024.60987695082;78140.60929695371;79326.20673793246;10367.792644147226;10496.842547361795;10528.526216320284;10567.841482377771;10697.625583104555;14548.199849008406;14589.781153282709;14591.708165836624;14599.927000365142;14603.853961460462;6714.697838597275;6716.731330746813;6906.447484201251;6921.965390173118;6961.79114626562;5945.464908158287;5988.760449582055;6146.938530614726;6147.66187859672;6156.107364432132;4450.621697155778;4452.821887124479;4491.865244042684;4502;4583.885402864888;1674.3218996306516;1792.8476079533125;1804;1829.6980998135425;1839.8160183981763;778.6262593954933;886.3219636977717;891.9955400222957;897.8473659477904;920.2913756407662;17422.11826328593;17641.647167056588;17854.464366069038;18537.629247414978;18795.624087518172;903.5256490342623;906.6146887572887;907.945523268606;912.0788004115891;929.9070092990647;9644.324897257125;9887.901120988841;10143.695689129338;10334.689959301233;10784.676459706221;461160;468690;475161;477820;482151;86518.56740716255;87882.12117878739;88501;89388;93401.0659893406;1000.2797985450464;1000.7798284377425;1025.3130402630106;1027.111548510548;1028.4138041316378;16293.266802993656;16326.510204693877;16668.833311666727;16941.830581694518;17044.48866534006;40230.798846005586;40954.38568421416;40986;41291.1741765157;43526.78236608923;55363;56716;57122.14316785168;58445;58964;7020.859582808213;7883.408744344082;8013.3188678960605;8110.594470276581;8279.840822284765;11830.881691182978;12578.245305281713;12787;12882.806757898452;13196.406161722938;10265.794684106426;10292.742681432725;10472.214583906085;10652.414117223627;10711.732206694895;10907.836382454429;11125.44372781374;11146.554137834395;11240.494177762184;11246.83129753038;10657.005698773404;10703.892961070289;11195.552177912792;11243.943780281046;11405.486753096297;7161;7165.928340716735;7215.71137154529;7267.963660181666;7576.090869095744;10448.477576121315;10636.202284828514;10695.572177112828;11521.078313735048;11601.839816018331 15:00:40 INFO - PROCESS | 8684 | |3;mootools.html;1356.7557839588874;1361.3669643615717;1368.1449094316054;1370.9314534273283;1371.972560548789;7095.077639906812;7527.322540971311;7572.469927105098;7573.166951635316;7579.73470928517;6543.509236807235;6705.094812200364;6930.203026651937;7106.289371062891;7388.298111679382;2189.485470914338;2234.653628687548;2235.474663454087;2235.765244649313;2239.9552008959813;2043.4584835018657;2085.228465467779;2089.676100204471;2091.905864236113;2092.3095378525127;1891.2624076610064;1923.0480911948534;2120.204923153817;2137.5190582119053;2179.1501314487364;1997.2111016148613;2001.7297664815283;2014.0735261779598;2015.2644284835928;2020.0404807716363;2039.225094464109;2067.648499755045;2075.3358925143807;2088.9477763055893;2130.2544109561686;7458.962705186494;7463.4029277657655;7522.097348318182;7523.322900938887;7533.886991695129;4344.391785150082;4482.0139569295025;4487.371767952489;4488.079943611552;4489.124620698965;2814.591884176783;2974.375381169957;2978.970210297891;3021.5165573508134;3061.785675002751;1111.3554138599593;1152.394992628868;1166.6383421139474;1191.154280460874;1211.660734994203;10002.399856008662;10020.098191162757;10037.197024238043;10039.14667253277;10044.99550044997;3971.7361104170345;4124.175164966959;4145.730527515701;4199.097194103221;4202.852900148541;8542.316614670935;8542.40203185771;8546.359023073295;8560.61477233526;8567.871481927776;4613.976930115328;4623.907521849612;4683.765811709401;4685.554872287127;4694.694844835075;3681.3738467609382;3699.1491956849536;4021.5174179098112;4242.427272318259;4267.445232119867;3460.567429071366;3496.650334966483;3597.1906321078072;3616.27674465108;3628.2380700053286;1152.464104191555;1175.6766889105565;1190.14309697018;1193.7552801675636;1194.5460724924474;761.4479502360855;835.052215735145;897.6947837735202;898.8427025270682;906.428949761646;5101.617378696613;5132.101882170605;5135.152699804565;5194.870128246748;5311.468853114658;919.6965001549472;935.0929598289648;940.9952950235205;944.5702205496483;981.1169947047572;3505.5618047744033;3600.6039335673577;3647.6717095461536;3657.341678497896;3760.3231418344412;8470.534120623302;8559.400841941004;8771.386002979858;8779.25376343018;9050.27597792175;9013.324000699973;9015.63937442508;9016.278697704169;9016.774580635405;9026.18764311215;6727.125473688487;6990.685419156151;7046.894296585555;7055.929440705528;7064.470164737665;5062.886165043685;5249.921251181312;5323.893522129459;5332.520073193431;5564.4713752193475;8178.591070446573;8191.303739182236;8195.836083278182;8226.465279756796;8240.917590824254;8207.507549547046;8309.210624990616;8340.457870238415;8344.874826877724;8429.157084291523;5723.255976723;5874.706264686834;6402.103705481143;6545.738170473128;6552.6723663817575;6795.38841504267;6978.511504194657;7033.191183014019;7207.603581803051;7218.927810721825;6283.120363149254;6330.651814150266;6334.524910631813;6516.869662606816;6521.608703477807;6169.598976066542;6180.443760061616;6185.226846644169;6202.379762023762;6245.0632405139595;5747.913781293368;5834.03738383162;5834.912476312774;5839.620424672383;5842.912356314574;4423;4467.8212871484775;4472.485664148665;4508.616767574662;4522.954770452254;4442.955570444255;4457.734969922578;4558.9772051139535;4653.139169253699;4703.647226458098 15:00:40 INFO - PROCESS | 8684 | |4;prototype.html;341.86496333948094;343.6391788621946;351.6747009016659;352.43610223642173;353.4662659384329;4821;4844.903101937959;4857.757112144396;4870.464248932614;4940;4843.515648435155;4855.53872382124;4867.318575399447;4873.658843880929;4885.584725298354;3710.3692372296705;3809.56190038145;3821.617838216184;3859.826307816141;3869.613038696136;3859.619332058106;3879.2047630235734;3883.689304855605;3894.201688653819;3894.3768996960493;3846.826892789831;3856.151646637735;3861.343571592836;3872.206197729473;3886.6696330811774;3716.6283371662753;3795.8291876865605;3804.752691075071;3869.226154769029;3881.9805900970455;3462.515247865301;3476.617572067071;3487.4071407860724;3494.702950249232;3496.965030349689;4681.976590117028;4689.953100468986;4713.858584242444;4730.266808644666;4747.406574178228;4287.49937521868;4429.13631841791;4432.73403595782;4439.422875026258;4462.995825939171;5069.264956581312;5071.56891664209;5075.923861142086;5105.361829771278;5117.360329958755;3808.7524310919703;3829.80850957451;3841.367418847007;3843.8654647087496;3854.69162467002;5126.538611524906;5305.920411193873;5339;5340.839774806762;5358.169483729989;3890.455336252927;3922.097917478996;3927.8232479538487;3929.7249192556246;3929.7838618876235;3982.900427489336;3984.143409167043;3986.8836725716847;3988.1824226033596;3998.5601583825755;4432.955670443319;4433.113377324484;4447.199504089295;4452.265376212953;4452.888677783081;4969.304297398367;5082.440931497532;5085.491450854959;5096.490350964948;5133.948660513422;1339.5914246155016;1340.4169186403751;1347.797830325459;1349.7368013237324;1356.4777560639225;914.2868562521244;951.3150531617224;954.8185844689486;961.2982522758425;967.666155176463;4268.5913648495925;4311.262348408783;4406;4471.642268618502;4474.888127796831;5175.53420192177;5193.636445448782;5193.844184674465;5196.844094677166;5207.453217412117;4330.913381732347;4381.101874115799;4435.534268901783;4456.220161471794;4459.866204013885;2561.743825617423;2678.504476671822;2689.9731002689723;2690.9908784205923;2720.7415295546894;4743.699305836666;4757.976210118996;4762.261849413347;4771.6898401603785;4775.617950563947;5139.511746384088;5155.587552995751;5158.92261616076;5210.166373380241;5264.104922227995;4577.153226653079;4873.366462359871;4918.704877707349;4927.9507204927495;4940.333055037524;5243.846353802158;5250.159974404077;5257.500537449089;5259.921101183561;5267.313670028389;4966.404031516241;5146.150885103916;5148.330717006766;5149.356330458692;5171.81898633546;4852.272159176152;4911.140550403737;4935.432425270996;4946.950530494649;4951.950480495293;3672.540932383452;3673.57753858299;3687.7418580699095;3689.133053732317;3690.8892733218045;5082.771275292546;5261.710605916712;5270.947290527046;5278.1027225372545;5298.523132918056;5080.392921026113;5118.539331460186;5120.487951204998;5129.384473863161;5151.304573882478;5108.335916330853;5111.386633603991;5119.769610367468;5130.4100028497205;5130.923036154535;4788.904221915473;5049.7727602257255;5060.3168572242275;5060.443351231288;5075.264086707333;4937.444704917939;4969.304297398439;5072.644914855925;5124.410692770379;5154.587632989277;4993.176125939324;4996.350474438445;4997.200447928314;5003.824866129668;5005.599552035756 15:00:40 INFO - PROCESS | 8684 | |5;yui.html;674.8043067510422;696.7387229788826;735.1986334894964;766.5170942306347;778.996105019475;12548;13751.662217423038;13753.89968802496;13758.042020965491;13758.793618095737;12575.119741618068;12662.620121396372;12678.175918565286;12701.110922235448;12706.110572259922;663.6947004377992;681.8363592737757;795.026093036032;797.7367468735304;809.5385630190793;812.7805492517017;830.8172202115555;832.3258160889668;832.8500869843426;833.995830020852;873.2228316798023;873.6025108575583;874.1739056591492;874.567089290802;875.0068672057197;699.0004293859829;718.6011763471271;840.2983508770124;870.9520976346298;871.9171678690547;636.6816591704148;639.3798015924592;639.8784230996096;640.1837656987378;640.4172203294979;13058.673533161653;13081.41133648988;13083.280419576919;13112.541061062817;13115.344232788322;12549.749005019848;12600.621981340575;12807.61577152687;12828.127802914056;13021.86978130216;11927.88072119285;12298.323592202425;12387.504499820086;12446.937765311206;13094.541691040768;3985.5217373915025;4012.6990475714438;4021.1756589899;4093.85671501499;4156.189543039109;69082.65458672725;69377.3062269376;69427.65286173536;69755.65122174357;71302.28697713009;10364.585416583403;10408.271421000609;10488.213383996079;10512.1590272778;10597.258191926645;20434.489137771674;20461.386158415273;20468.283610073577;20473.07871145772;20516.692249616266;6730.9326906731285;6777.186737591521;6885.483588730765;6926.653667316614;6993.510454268152;3518.6481351865123;3525.4359302511475;3567.35787558242;3576.499290099388;3582.802945838004;2920.897768578132;2982.6122604061334;2999.9400012000074;3004.819710817358;3022.969770302269;488.80401333821254;489.50070927654303;489.58629957685696;501.6739119572307;503.14214264678634;547.3787251469531;549.4725063938583;566.770457964525;575.3527281807966;580.561675934675;7979.72070977513;8041.959790201128;8245.95877020611;8273.296769774637;8456;501.59120316941573;503.3230305239447;508.47118996243495;558.8602849287678;576.5935015813841;3703.9629603704157;3724.5530536335814;3743.1577894973957;3781.565120011179;3915.4126880968083;71033.64483177551;71481;71681.2831871685;73102;73258.63370683219;63647.681761590895;64437;64602.676986614766;64989.350106499274;65762;43682;53254.46745532495;54195.45804541983;54926;55220.72389638107;7551.773446796605;7852.489588176751;7918.841623167389;8028.87956680662;8032.437729358889;38970.80514597409;39369.40945885871;39505.80247098746;40222.79888600538;40390.19219615532;41453.378199327635;42176.36735448909;44003.77998109989;45361.31958020698;47196.7640161797;10418.01028902253;10503.527341269813;10561.89438105609;10683.198760093179;10834.02493775564;11527.423628818693;11719.476468059438;11876.990455811352;12090.032797376365;12118.878811211775;10637.893621063691;10684.626038088629;10977.670669879917;11061.336319820837;11398.430078495876;11857.229280096766;12245.693857653274;12842.293673848028;12946.935265323613;13060;11477.655670329903;11651;11790.705232369259;12411.875881241433;12428.13003089775;9811.656592019244;10271.229657775846;10544.314619549705;10695;10722.088622467178;9009.144131307516;9054.864177037482;9622.711318660451;9629.614815407585;9802.36284641496 15:00:40 INFO - PROCESS | 8684 | __end_tp_report 15:00:40 INFO - PROCESS | 8684 | __start_cc_report 15:00:40 INFO - PROCESS | 8684 | _x_x_mozilla_cycle_collect,1235 15:00:40 INFO - PROCESS | 8684 | __end_cc_report 15:00:40 INFO - PROCESS | 8684 | __startTimestamp1484089240738__endTimestamp 15:00:40 INFO - PROCESS | 8684 | 15:00:40 INFO - PROCESS | 8684 | ------- Summary: start ------- 15:00:40 INFO - PROCESS | 8684 | Number of tests: 6 15:00:40 INFO - PROCESS | 8684 | 15:00:40 INFO - PROCESS | 8684 | [#0] dojo.html Cycles:165 Average:4807.77 Median:4987.93 stddev:522.00 (10.5%) stddev-sans-first:494.27 15:00:40 INFO - PROCESS | 8684 | Values: 2608.3 2633.4 2655.6 2664.0 2665.5 4761.8 4789.9 4835.2 4928.8 4955.5 4876.3 4879.3 4902.5 4947.7 4996.8 4388.7 4415.1 4455.4 4491.6 4502.1 4059.5 4464.8 4518.8 4552.2 4597.4 4388.8 4457.9 4464.6 4484.0 4562.8 4400.9 4451.9 4455.7 4459.0 4463.5 4421.8 4437.4 4443.0 4444.5 4445.5 4809.6 4855.5 4868.4 4885.6 4892.7 5164.1 5277.8 5277.9 5279.9 5281.3 5244.9 5247.0 5250.9 5268.1 5279.4 4853.2 4987.9 4989.5 5002.6 5038.5 5168.2 5246.4 5283.1 5467.7 5468.6 5117.7 5122.5 5122.7 5124.5 5126.7 5148.5 5218.4 5220.2 5231.8 5233.5 5108.4 5116.3 5120.0 5122.6 5186.3 5110.6 5113.5 5117.7 5123.0 5123.1 4355.5 4371.5 4374.7 4374.8 4374.8 3746.5 3800.5 3809.8 3892.4 3901.2 4431.3 4433.8 4439.5 4473.2 4473.5 5083.6 5173.7 5181.0 5183.9 5194.0 4406.0 4444.8 4487.7 4502.3 4503.3 4740.9 4742.5 4745.8 4781.9 4796.4 4925.7 4930.5 4930.7 4933.6 4976.7 5112.8 5114.1 5120.8 5175.8 5259.8 4750.7 4828.6 4845.1 4847.2 4847.7 5095.4 5098.5 5100.6 5109.0 5110.0 5128.3 5204.7 5210.6 5250.0 5267.0 5097.1 5129.8 5137.6 5140.2 5145.4 4930.7 4988.5 4993.7 5102.3 5176.1 5069.1 5092.7 5101.5 5131.3 5144.9 5150.6 5169.9 5180.7 5181.8 5226.6 4830.0 5024.0 5024.9 5028.5 5065.3 15:00:40 INFO - PROCESS | 8684 | 15:00:40 INFO - PROCESS | 8684 | [#1] ext.html Cycles:180 Average:42189.36 Median:175499.14 stddev:71099.12 (40.5%) stddev-sans-first:71229.70 15:00:40 INFO - PROCESS | 8684 | Values: 509.7 537.1 543.6 548.8 552.0 28866.3 39005.0 41004.3 41079.8 46037.3 42617.8 43067.4 43076.8 43218.6 43231.6 7616.9 7728.6 7923.0 7932.0 7938.4 7503.2 10006.2 10329.9 10336.9 10699.4 9865.3 9875.8 9923.6 9936.0 9944.5 10328.3 10392.6 10397.8 10409.7 10409.8 10171.5 10238.1 10255.8 10260.3 10268.7 39874.4 40252.6 40253.0 40290.0 40304.2 3753.7 3757.3 3778.1 3787.0 3858.0 30157.5 30378.7 30541.2 30686.2 31849.2 3323.3 3424.6 3489.6 3528.6 3540.4 268794.0 268829.0 269484.0 269757.0 270464.0 49197.5 49590.3 49610.3 49697.8 49778.3 51929.7 52056.5 52113.5 52289.5 52379.5 12614.4 12768.9 12770.6 12803.6 12806.4 8659.0 8850.9 9714.4 9754.5 9853.6 16123.5 16688.7 16692.5 16725.8 17052.2 6535.6 6615.9 6765.9 6791.9 6841.2 803.5 827.6 828.0 844.1 860.9 28175.9 28465.6 28892.9 29376.0 29427.6 953.9 980.1 991.7 996.5 1000.9 15152.7 15195.8 15349.8 15373.6 15390.4 140255.0 141150.0 141338.3 141594.0 141653.0 54412.7 54776.2 54930.5 54995.0 55000.2 1235.4 1267.2 1268.9 1283.5 1285.6 26844.6 27059.2 27403.0 28260.9 28336.4 47010.3 48476.5 48561.0 48607.0 48670.5 347573.7 355659.0 356525.0 357578.0 358218.0 28948.1 28976.8 31257.2 35497.3 35994.6 34778.5 38014.2 38216.2 38264.8 38478.8 32743.8 32984.0 33294.3 33361.7 34215.5 32579.5 32583.3 32597.7 32831.0 33042.3 32306.8 32393.7 32498.0 32512.2 32588.5 25487.5 26284.0 29060.4 29066.3 29360.9 22264.8 22608.2 22937.3 23048.8 23075.0 15:00:40 INFO - PROCESS | 8684 | 15:00:40 INFO - PROCESS | 8684 | [#2] jquery.html Cycles:180 Average:27738.28 Median:20316.60 stddev:78070.39 (384.3%) stddev-sans-first:78262.35 15:00:40 INFO - PROCESS | 8684 | Values: 368.1 382.6 385.8 386.0 402.4 16355.1 18296.4 18697.1 18791.2 18794.1 16922.9 18136.5 18337.4 18534.8 18545.9 5162.8 5296.3 5327.0 5332.5 5336.3 3860.7 4035.6 6284.1 6297.3 6403.4 6099.8 6327.6 6337.2 6339.5 6340.9 6224.6 6294.7 6297.0 6309.1 6309.9 4963.3 5172.0 5228.9 5552.0 5556.1 12463.1 12583.3 15878.1 21230.9 21626.5 2194.0 2214.3 2221.2 2246.2 2262.9 9654.0 9957.6 9959.8 10685.1 13577.7 1683.0 1714.7 1755.0 1756.3 1757.4 75239.0 77342.0 78024.6 78140.6 79326.2 10367.8 10496.8 10528.5 10567.8 10697.6 14548.2 14589.8 14591.7 14599.9 14603.9 6714.7 6716.7 6906.4 6922.0 6961.8 5945.5 5988.8 6146.9 6147.7 6156.1 4450.6 4452.8 4491.9 4502.0 4583.9 1674.3 1792.8 1804.0 1829.7 1839.8 778.6 886.3 892.0 897.8 920.3 17422.1 17641.6 17854.5 18537.6 18795.6 903.5 906.6 907.9 912.1 929.9 9644.3 9887.9 10143.7 10334.7 10784.7 461160.0 468690.0 475161.0 477820.0 482151.0 86518.6 87882.1 88501.0 89388.0 93401.1 1000.3 1000.8 1025.3 1027.1 1028.4 16293.3 16326.5 16668.8 16941.8 17044.5 40230.8 40954.4 40986.0 41291.2 43526.8 55363.0 56716.0 57122.1 58445.0 58964.0 7020.9 7883.4 8013.3 8110.6 8279.8 11830.9 12578.2 12787.0 12882.8 13196.4 10265.8 10292.7 10472.2 10652.4 10711.7 10907.8 11125.4 11146.6 11240.5 11246.8 10657.0 10703.9 11195.6 11243.9 11405.5 7161.0 7165.9 7215.7 7268.0 7576.1 10448.5 10636.2 10695.6 11521.1 11601.8 15:00:40 INFO - PROCESS | 8684 | 15:00:40 INFO - PROCESS | 8684 | [#3] mootools.html Cycles:180 Average:4897.30 Median:5082.25 stddev:2634.34 (51.8%) stddev-sans-first:2628.29 15:00:40 INFO - PROCESS | 8684 | Values: 1356.8 1361.4 1368.1 1370.9 1372.0 7095.1 7527.3 7572.5 7573.2 7579.7 6543.5 6705.1 6930.2 7106.3 7388.3 2189.5 2234.7 2235.5 2235.8 2240.0 2043.5 2085.2 2089.7 2091.9 2092.3 1891.3 1923.0 2120.2 2137.5 2179.2 1997.2 2001.7 2014.1 2015.3 2020.0 2039.2 2067.6 2075.3 2088.9 2130.3 7459.0 7463.4 7522.1 7523.3 7533.9 4344.4 4482.0 4487.4 4488.1 4489.1 2814.6 2974.4 2979.0 3021.5 3061.8 1111.4 1152.4 1166.6 1191.2 1211.7 10002.4 10020.1 10037.2 10039.1 10045.0 3971.7 4124.2 4145.7 4199.1 4202.9 8542.3 8542.4 8546.4 8560.6 8567.9 4614.0 4623.9 4683.8 4685.6 4694.7 3681.4 3699.1 4021.5 4242.4 4267.4 3460.6 3496.7 3597.2 3616.3 3628.2 1152.5 1175.7 1190.1 1193.8 1194.5 761.4 835.1 897.7 898.8 906.4 5101.6 5132.1 5135.2 5194.9 5311.5 919.7 935.1 941.0 944.6 981.1 3505.6 3600.6 3647.7 3657.3 3760.3 8470.5 8559.4 8771.4 8779.3 9050.3 9013.3 9015.6 9016.3 9016.8 9026.2 6727.1 6990.7 7046.9 7055.9 7064.5 5062.9 5249.9 5323.9 5332.5 5564.5 8178.6 8191.3 8195.8 8226.5 8240.9 8207.5 8309.2 8340.5 8344.9 8429.2 5723.3 5874.7 6402.1 6545.7 6552.7 6795.4 6978.5 7033.2 7207.6 7218.9 6283.1 6330.7 6334.5 6516.9 6521.6 6169.6 6180.4 6185.2 6202.4 6245.1 5747.9 5834.0 5834.9 5839.6 5842.9 4423.0 4467.8 4472.5 4508.6 4523.0 4443.0 4457.7 4559.0 4653.1 4703.6 15:00:40 INFO - PROCESS | 8684 | 15:00:40 INFO - PROCESS | 8684 | [#4] prototype.html Cycles:180 Average:4249.14 Median:4782.26 stddev:1199.06 (25.1%) stddev-sans-first:1166.01 15:00:40 INFO - PROCESS | 8684 | Values: 341.9 343.6 351.7 352.4 353.5 4821.0 4844.9 4857.8 4870.5 4940.0 4843.5 4855.5 4867.3 4873.7 4885.6 3710.4 3809.6 3821.6 3859.8 3869.6 3859.6 3879.2 3883.7 3894.2 3894.4 3846.8 3856.2 3861.3 3872.2 3886.7 3716.6 3795.8 3804.8 3869.2 3882.0 3462.5 3476.6 3487.4 3494.7 3497.0 4682.0 4690.0 4713.9 4730.3 4747.4 4287.5 4429.1 4432.7 4439.4 4463.0 5069.3 5071.6 5075.9 5105.4 5117.4 3808.8 3829.8 3841.4 3843.9 3854.7 5126.5 5305.9 5339.0 5340.8 5358.2 3890.5 3922.1 3927.8 3929.7 3929.8 3982.9 3984.1 3986.9 3988.2 3998.6 4433.0 4433.1 4447.2 4452.3 4452.9 4969.3 5082.4 5085.5 5096.5 5133.9 1339.6 1340.4 1347.8 1349.7 1356.5 914.3 951.3 954.8 961.3 967.7 4268.6 4311.3 4406.0 4471.6 4474.9 5175.5 5193.6 5193.8 5196.8 5207.5 4330.9 4381.1 4435.5 4456.2 4459.9 2561.7 2678.5 2690.0 2691.0 2720.7 4743.7 4758.0 4762.3 4771.7 4775.6 5139.5 5155.6 5158.9 5210.2 5264.1 4577.2 4873.4 4918.7 4928.0 4940.3 5243.8 5250.2 5257.5 5259.9 5267.3 4966.4 5146.2 5148.3 5149.4 5171.8 4852.3 4911.1 4935.4 4947.0 4952.0 3672.5 3673.6 3687.7 3689.1 3690.9 5082.8 5261.7 5270.9 5278.1 5298.5 5080.4 5118.5 5120.5 5129.4 5151.3 5108.3 5111.4 5119.8 5130.4 5130.9 4788.9 5049.8 5060.3 5060.4 5075.3 4937.4 4969.3 5072.6 5124.4 5154.6 4993.2 4996.4 4997.2 5003.8 5005.6 15:00:40 INFO - PROCESS | 8684 | 15:00:40 INFO - PROCESS | 8684 | [#5] yui.html Cycles:180 Average:15535.87 Median:42929.18 stddev:19988.34 (46.6%) stddev-sans-first:20013.27 15:00:40 INFO - PROCESS | 8684 | Values: 674.8 696.7 735.2 766.5 779.0 12548.0 13751.7 13753.9 13758.0 13758.8 12575.1 12662.6 12678.2 12701.1 12706.1 663.7 681.8 795.0 797.7 809.5 812.8 830.8 832.3 832.9 834.0 873.2 873.6 874.2 874.6 875.0 699.0 718.6 840.3 871.0 871.9 636.7 639.4 639.9 640.2 640.4 13058.7 13081.4 13083.3 13112.5 13115.3 12549.7 12600.6 12807.6 12828.1 13021.9 11927.9 12298.3 12387.5 12446.9 13094.5 3985.5 4012.7 4021.2 4093.9 4156.2 69082.7 69377.3 69427.7 69755.7 71302.3 10364.6 10408.3 10488.2 10512.2 10597.3 20434.5 20461.4 20468.3 20473.1 20516.7 6730.9 6777.2 6885.5 6926.7 6993.5 3518.6 3525.4 3567.4 3576.5 3582.8 2920.9 2982.6 2999.9 3004.8 3023.0 488.8 489.5 489.6 501.7 503.1 547.4 549.5 566.8 575.4 580.6 7979.7 8042.0 8246.0 8273.3 8456.0 501.6 503.3 508.5 558.9 576.6 3704.0 3724.6 3743.2 3781.6 3915.4 71033.6 71481.0 71681.3 73102.0 73258.6 63647.7 64437.0 64602.7 64989.4 65762.0 43682.0 53254.5 54195.5 54926.0 55220.7 7551.8 7852.5 7918.8 8028.9 8032.4 38970.8 39369.4 39505.8 40222.8 40390.2 41453.4 42176.4 44003.8 45361.3 47196.8 10418.0 10503.5 10561.9 10683.2 10834.0 11527.4 11719.5 11877.0 12090.0 12118.9 10637.9 10684.6 10977.7 11061.3 11398.4 11857.2 12245.7 12842.3 12946.9 13060.0 11477.7 11651.0 11790.7 12411.9 12428.1 9811.7 10271.2 10544.3 10695.0 10722.1 9009.1 9054.9 9622.7 9629.6 9802.4 15:00:40 INFO - PROCESS | 8684 | -------- Summary: end -------- 15:00:40 INFO - PROCESS | 8684 | 15:00:41 INFO - TEST-INFO | 8684: exit 0 15:00:41 INFO - TEST-OK | dromaeo_css | took 1122512ms 15:00:41 INFO - TEST-START | kraken 15:00:41 INFO - operating with platform_type : linux_ 15:00:41 INFO - Initialising browser for kraken test... 15:00:41 INFO - TEST-INFO | started process 8983 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8kHryX/profile http://localhost:54918/getInfo.html) 15:00:45 INFO - PROCESS | 8983 | __metrics Screen width/height:1600/1200 15:00:45 INFO - PROCESS | 8983 | colorDepth:24 15:00:45 INFO - PROCESS | 8983 | Browser inner width/height: 1024/697 15:00:45 INFO - PROCESS | 8983 | __metrics 15:00:46 INFO - PROCESS | 8983 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:00:46 INFO - PROCESS | 8983 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:00:46 INFO - PROCESS | 8983 | console.error: PushService: 15:00:46 INFO - PROCESS | 8983 | stateChangeProcessEnqueue: Error transitioning state 15:00:46 INFO - PROCESS | 8983 | UnknownError 15:00:47 INFO - TEST-INFO | 8983: exit 0 15:00:47 INFO - Browser initialized. 15:00:47 INFO - Running cycle 1/1 for kraken test... 15:00:47 INFO - TEST-INFO | started process 9068 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8kHryX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:00:59 INFO - PROCESS | 9068 | RSS: Main: 151412736 15:00:59 INFO - PROCESS | 9068 | 15:01:02 INFO - PROCESS | 9068 | Cycle 1(1): loaded http://localhost:54918/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54918/tests/kraken/driver.html?testName=audio-beat-detection) 15:01:03 INFO - PROCESS | 9068 | RSS: Main: 206094336 15:01:03 INFO - PROCESS | 9068 | 15:01:05 INFO - PROCESS | 9068 | Cycle 1(1): loaded http://localhost:54918/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54918/tests/kraken/driver.html?testName=audio-dft) 15:01:06 INFO - PROCESS | 9068 | RSS: Main: 187142144 15:01:06 INFO - PROCESS | 9068 | 15:01:09 INFO - PROCESS | 9068 | Cycle 1(1): loaded http://localhost:54918/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54918/tests/kraken/driver.html?testName=audio-fft) 15:01:10 INFO - PROCESS | 9068 | RSS: Main: 268640256 15:01:10 INFO - PROCESS | 9068 | 15:01:12 INFO - PROCESS | 9068 | Cycle 1(1): loaded http://localhost:54918/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54918/tests/kraken/driver.html?testName=audio-oscillator) 15:01:12 INFO - PROCESS | 9068 | RSS: Main: 178765824 15:01:12 INFO - PROCESS | 9068 | 15:01:15 INFO - PROCESS | 9068 | Cycle 1(1): loaded http://localhost:54918/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54918/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:01:15 INFO - PROCESS | 9068 | RSS: Main: 182947840 15:01:15 INFO - PROCESS | 9068 | 15:01:18 INFO - PROCESS | 9068 | Cycle 1(1): loaded http://localhost:54918/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54918/tests/kraken/driver.html?testName=imaging-darkroom) 15:01:19 INFO - PROCESS | 9068 | RSS: Main: 221581312 15:01:19 INFO - PROCESS | 9068 | 15:01:22 INFO - PROCESS | 9068 | Cycle 1(1): loaded http://localhost:54918/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54918/tests/kraken/driver.html?testName=imaging-desaturate) 15:01:23 INFO - PROCESS | 9068 | RSS: Main: 216219648 15:01:23 INFO - PROCESS | 9068 | 15:01:26 INFO - PROCESS | 9068 | Cycle 1(1): loaded http://localhost:54918/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54918/tests/kraken/driver.html?testName=json-parse-financial) 15:01:26 INFO - PROCESS | 9068 | RSS: Main: 217649152 15:01:26 INFO - PROCESS | 9068 | 15:01:28 INFO - PROCESS | 9068 | Cycle 1(1): loaded http://localhost:54918/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54918/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:01:29 INFO - PROCESS | 9068 | RSS: Main: 181751808 15:01:29 INFO - PROCESS | 9068 | 15:01:31 INFO - PROCESS | 9068 | Cycle 1(1): loaded http://localhost:54918/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54918/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:01:31 INFO - PROCESS | 9068 | RSS: Main: 189304832 15:01:31 INFO - PROCESS | 9068 | 15:01:34 INFO - PROCESS | 9068 | Cycle 1(1): loaded http://localhost:54918/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54918/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:01:34 INFO - PROCESS | 9068 | RSS: Main: 197550080 15:01:34 INFO - PROCESS | 9068 | 15:01:37 INFO - PROCESS | 9068 | Cycle 1(1): loaded http://localhost:54918/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54918/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:01:38 INFO - PROCESS | 9068 | RSS: Main: 202379264 15:01:38 INFO - PROCESS | 9068 | 15:01:41 INFO - PROCESS | 9068 | Cycle 1(1): loaded http://localhost:54918/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54918/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:01:41 INFO - PROCESS | 9068 | RSS: Main: 203292672 15:01:41 INFO - PROCESS | 9068 | 15:01:43 INFO - PROCESS | 9068 | Cycle 1(1): loaded http://localhost:54918/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54918/tests/kraken/driver.html?testName=ai-astar) 15:01:43 INFO - PROCESS | 9068 | RSS: Main: 253599744 15:01:43 INFO - PROCESS | 9068 | 15:01:43 INFO - PROCESS | 9068 | __start_tp_report 15:01:43 INFO - PROCESS | 9068 | _x_x_mozilla_page_load 15:01:43 INFO - PROCESS | 9068 | _x_x_mozilla_page_load_details 15:01:43 INFO - PROCESS | 9068 | |i|pagename|runs| 15:01:43 INFO - PROCESS | 9068 | |0;ai-astar;113;117;115;116;115;115;114;116;115;116 15:01:43 INFO - PROCESS | 9068 | |1;audio-beat-detection;158;124;125;160;129;128;126;121;147;122 15:01:43 INFO - PROCESS | 9068 | |2;audio-dft;161;162;160;160;161;164;161;159;160;160 15:01:43 INFO - PROCESS | 9068 | |3;audio-fft;76;76;76;105;78;77;76;76;102;77 15:01:43 INFO - PROCESS | 9068 | |4;audio-oscillator;84;85;107;85;85;84;101;85;84;101 15:01:43 INFO - PROCESS | 9068 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;119 15:01:43 INFO - PROCESS | 9068 | |6;imaging-darkroom;149;149;151;149;148;149;149;148;149;148 15:01:43 INFO - PROCESS | 9068 | |7;imaging-desaturate;95;94;95;95;95;95;95;95;95;95 15:01:43 INFO - PROCESS | 9068 | |8;json-parse-financial;60;60;60;60;60;61;61;61;61;68 15:01:43 INFO - PROCESS | 9068 | |9;json-stringify-tinderbox;67;69;68;68;69;68;68;68;68;69 15:01:43 INFO - PROCESS | 9068 | |10;stanford-crypto-aes;85;95;85;88;84;85;86;85;94;83 15:01:43 INFO - PROCESS | 9068 | |11;stanford-crypto-ccm;137;132;135;131;130;139;131;138;221;143 15:01:43 INFO - PROCESS | 9068 | |12;stanford-crypto-pbkdf2;184;175;190;174;173;171;174;175;171;186 15:01:43 INFO - PROCESS | 9068 | |13;stanford-crypto-sha256-iterative;68;73;69;69;69;68;68;72;70;66 15:01:43 INFO - PROCESS | 9068 | __end_tp_report 15:01:43 INFO - PROCESS | 9068 | __start_cc_report 15:01:43 INFO - PROCESS | 9068 | _x_x_mozilla_cycle_collect,1820 15:01:43 INFO - PROCESS | 9068 | __end_cc_report 15:01:43 INFO - PROCESS | 9068 | __startTimestamp1484089303819__endTimestamp 15:01:43 INFO - PROCESS | 9068 | 15:01:43 INFO - PROCESS | 9068 | ------- Summary: start ------- 15:01:43 INFO - PROCESS | 9068 | Number of tests: 14 15:01:43 INFO - PROCESS | 9068 | 15:01:43 INFO - PROCESS | 9068 | [#0] ai-astar Cycles:10 Average:115.20 Median:115.50 stddev:1.14 (1.0%) stddev-sans-first:0.88 15:01:43 INFO - PROCESS | 9068 | Values: 113.0 117.0 115.0 116.0 115.0 115.0 114.0 116.0 115.0 116.0 15:01:43 INFO - PROCESS | 9068 | 15:01:43 INFO - PROCESS | 9068 | [#1] audio-beat-detection Cycles:10 Average:134.00 Median:128.50 stddev:15.06 (11.7%) stddev-sans-first:13.23 15:01:43 INFO - PROCESS | 9068 | Values: 158.0 124.0 125.0 160.0 129.0 128.0 126.0 121.0 147.0 122.0 15:01:43 INFO - PROCESS | 9068 | 15:01:43 INFO - PROCESS | 9068 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.40 (0.9%) stddev-sans-first:1.48 15:01:43 INFO - PROCESS | 9068 | Values: 161.0 162.0 160.0 160.0 161.0 164.0 161.0 159.0 160.0 160.0 15:01:43 INFO - PROCESS | 9068 | 15:01:43 INFO - PROCESS | 9068 | [#3] audio-fft Cycles:10 Average:81.90 Median:76.00 stddev:11.43 (15.0%) stddev-sans-first:11.92 15:01:43 INFO - PROCESS | 9068 | Values: 76.0 76.0 76.0 105.0 78.0 77.0 76.0 76.0 102.0 77.0 15:01:43 INFO - PROCESS | 9068 | 15:01:43 INFO - PROCESS | 9068 | [#4] audio-oscillator Cycles:10 Average:90.10 Median:84.50 stddev:9.06 (10.7%) stddev-sans-first:9.34 15:01:43 INFO - PROCESS | 9068 | Values: 84.0 85.0 107.0 85.0 85.0 84.0 101.0 85.0 84.0 101.0 15:01:43 INFO - PROCESS | 9068 | 15:01:43 INFO - PROCESS | 9068 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 15:01:43 INFO - PROCESS | 9068 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 119.0 15:01:43 INFO - PROCESS | 9068 | 15:01:43 INFO - PROCESS | 9068 | [#6] imaging-darkroom Cycles:10 Average:148.90 Median:149.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 15:01:43 INFO - PROCESS | 9068 | Values: 149.0 149.0 151.0 149.0 148.0 149.0 149.0 148.0 149.0 148.0 15:01:43 INFO - PROCESS | 9068 | 15:01:43 INFO - PROCESS | 9068 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 15:01:43 INFO - PROCESS | 9068 | Values: 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 15:01:43 INFO - PROCESS | 9068 | 15:01:43 INFO - PROCESS | 9068 | [#8] json-parse-financial Cycles:10 Average:61.20 Median:61.00 stddev:2.44 (4.0%) stddev-sans-first:2.55 15:01:43 INFO - PROCESS | 9068 | Values: 60.0 60.0 60.0 60.0 60.0 61.0 61.0 61.0 61.0 68.0 15:01:43 INFO - PROCESS | 9068 | 15:01:43 INFO - PROCESS | 9068 | [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.00 stddev:0.63 (0.9%) stddev-sans-first:0.50 15:01:43 INFO - PROCESS | 9068 | Values: 67.0 69.0 68.0 68.0 69.0 68.0 68.0 68.0 68.0 69.0 15:01:43 INFO - PROCESS | 9068 | 15:01:43 INFO - PROCESS | 9068 | [#10] stanford-crypto-aes Cycles:10 Average:87.00 Median:85.50 stddev:4.16 (4.9%) stddev-sans-first:4.35 15:01:43 INFO - PROCESS | 9068 | Values: 85.0 95.0 85.0 88.0 84.0 85.0 86.0 85.0 94.0 83.0 15:01:43 INFO - PROCESS | 9068 | 15:01:43 INFO - PROCESS | 9068 | [#11] stanford-crypto-ccm Cycles:10 Average:143.70 Median:137.50 stddev:27.48 (20.0%) stddev-sans-first:29.04 15:01:43 INFO - PROCESS | 9068 | Values: 137.0 132.0 135.0 131.0 130.0 139.0 131.0 138.0 221.0 143.0 15:01:43 INFO - PROCESS | 9068 | 15:01:43 INFO - PROCESS | 9068 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.30 Median:175.00 stddev:6.77 (3.9%) stddev-sans-first:6.73 15:01:43 INFO - PROCESS | 9068 | Values: 184.0 175.0 190.0 174.0 173.0 171.0 174.0 175.0 171.0 186.0 15:01:43 INFO - PROCESS | 9068 | 15:01:43 INFO - PROCESS | 9068 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:69.00 stddev:2.04 (3.0%) stddev-sans-first:2.12 15:01:43 INFO - PROCESS | 9068 | Values: 68.0 73.0 69.0 69.0 69.0 68.0 68.0 72.0 70.0 66.0 15:01:43 INFO - PROCESS | 9068 | -------- Summary: end -------- 15:01:43 INFO - PROCESS | 9068 | 15:01:44 INFO - TEST-INFO | 9068: exit 0 15:01:44 INFO - TEST-OK | kraken | took 63356ms 15:01:44 INFO - SUITE-END | took 1185s 15:01:44 INFO - Completed test suite (00:19:45) 15:01:44 INFO - javascript benchmark 15:01:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2608.3087981684853, 2633.354828067124, 2655.601659751038, 2664.0276299150805, 2665.5068812269733, 4761.761911904408, 4789.928151077736, 4835.153848076586, 4928.802847886085, 4955.52922472365, 4876.292937524066, 4879.268109783534, 4902.509749025105, 4947.7031378117335, 4996.825111121111, 4388.67084968627, 4415.094905544372, 4455.353973673816, 4491.554619121554, 4502.144592527409, 4059.4925634295714, 4464.776761161945, 4518.774061296938, 4552.248878934988, 4597.379353787246, 4388.802503887333, 4457.888552786207, 4464.6428285737065, 4483.955160448402, 4562.84030058948, 4400.867973960786, 4451.910961780746, 4455.732656040648, 4459.019015816515, 4463.464384273875, 4421.823127074913, 4437.423134992463, 4442.977785111054, 4444.488883778375, 4445.533219012022, 4809.567138957475, 4855.514448555152, 4868.440129385095, 4885.60915126789, 4892.68197567157, 5164.1220992431, 5277.788888444457, 5277.86805329866, 5279.868003299948, 5281.313429254173, 5244.895102097937, 5247.0, 5250.947490525123, 5268.078086334876, 5279.41926388097, 4853.150698627761, 4987.925181122286, 4989.525995030466, 5002.624803139706, 5038.496150384932, 5168.198929165986, 5246.449122842047, 5283.128283833124, 5467.726613669301, 5468.589855760754, 5117.71852548106, 5122.513361230752, 5122.718250496184, 5124.487551244845, 5126.6923984561045, 5148.536631703165, 5218.399884013387, 5220.243064755589, 5231.790728370898, 5233.502817232356, 5108.438071812097, 5116.3348764661105, 5120.0, 5122.615803814729, 5186.273921650972, 5110.642255042186, 5113.53978141969, 5117.667351622133, 5122.9743851281255, 5123.103456895028, 4355.477342718894, 4371.540988196257, 4374.650027997753, 4374.846880359172, 4374.846880359172, 3746.456763769238, 3800.5439347278502, 3809.790461524643, 3892.4161375793856, 3901.2002539479904, 4431.313146462304, 4433.7561434121435, 4439.489458712224, 4473.172463094338, 4473.507914129443, 5083.567896728746, 5173.741312934339, 5181.0, 5183.896322073538, 5194.039102765925, 4405.977970110129, 4444.755538445352, 4487.708298960557, 4502.257127573979, 4503.279475284005, 4740.928886066712, 4742.549457801572, 4745.762711864393, 4781.9043619128115, 4796.37647105874, 4925.655204135676, 4930.482299358516, 4930.728809915561, 4933.55597996182, 4976.701397916137, 5112.846614601568, 5114.105031619526, 5120.846374608767, 5175.81884634036, 5259.789608415621, 4750.714957102585, 4828.61371090319, 4845.103655823684, 4847.224444088929, 4847.709137451764, 5095.414027386898, 5098.515641014098, 5100.6429549931145, 5109.029284436094, 5110.0, 5128.282040514257, 5204.713740744295, 5210.583153347648, 5249.9737501313775, 5267.0, 5097.133487307093, 5129.79480820763, 5137.614678899023, 5140.20326849324, 5145.408278048072, 4930.6795058321095, 4988.4762099980435, 4993.700377977333, 5102.285680004728, 5176.1200595899545, 5069.062223488519, 5092.668976516515, 5101.464346243591, 5131.281620573197, 5144.897102058013, 5150.587952963829, 5169.870753231049, 5180.6891586504935, 5181.844544663666, 5226.555742761756, 4830.0, 5024.045431368028, 5024.924626130538, 5028.472010438997, 5065.316182315488], "value": 4772.964143891548, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [509.66107538486904, 537.1030379266622, 543.6357640380944, 548.7503186050346, 552.0063885006989, 28866.278343041435, 39005.0, 41004.284507281634, 41079.79460102695, 46037.30944035842, 42617.78691106548, 43067.35398969018, 43076.784616076955, 43218.56781432185, 43231.56768432315, 7616.885746713804, 7728.6088504069385, 7923.049234091917, 7932.0, 7938.44430889838, 7503.212162722917, 10006.249531285146, 10329.948350258239, 10336.89663103367, 10699.358038517714, 9865.309428340019, 9875.753106172331, 9923.553440095176, 9935.950320248425, 9944.453055081967, 10328.328658637165, 10392.584296628125, 10397.792044159074, 10409.73975650611, 10409.79180416395, 10171.54228059739, 10238.078572928398, 10255.79488410235, 10260.281780275383, 10268.743281418025, 39874.40188397176, 40252.59747402518, 40253.0, 40290.0, 40304.19391612151, 3753.71847111465, 3757.28611563802, 3778.1121436462686, 3786.992893766308, 3858.0, 30157.547636785464, 30378.69621303781, 30541.236469088228, 30686.232844178852, 31849.203769905707, 3323.2522682396266, 3424.5548078749603, 3489.5986961499243, 3528.629493903129, 3540.3627347077772, 268794.0, 268829.0, 269484.0, 269757.0, 270464.0, 49197.50802492001, 49590.25614615784, 49610.255846162334, 49697.75151124221, 49778.25332620014, 51929.74035129876, 52056.47943520592, 52113.47886521162, 52289.47710522922, 52379.47620523746, 12614.369281535886, 12768.93615531935, 12770.637432075097, 12803.551875684307, 12806.42371093303, 8659.0, 8850.867236991451, 9714.417134971924, 9754.512274386394, 9853.605855765689, 16123.516294511184, 16688.74966875498, 16692.499225023268, 16725.832741672428, 17052.2326495308, 6535.640539770358, 6615.933840661628, 6765.887691661891, 6791.932080679228, 6841.247462779091, 803.5379656697305, 827.5531213144834, 828.0436096308773, 844.0673056272852, 860.9354298427518, 28175.859120704674, 28465.57301640477, 28892.855535722607, 29376.0, 29427.558586621217, 953.9475328856979, 980.1374790184734, 991.6677912899115, 996.5067291690659, 1000.8999100090078, 15152.696946061016, 15195.772063419057, 15349.846501535065, 15373.627800585267, 15390.384384624489, 140255.0, 141150.0, 141338.2933085328, 141594.0, 141653.0, 54412.72793636007, 54776.17835732467, 54930.45069549333, 54995.0, 55000.17499737507, 1235.3576140406938, 1267.1889990406332, 1268.879456451654, 1283.5186804948144, 1285.633594425603, 26844.617730124373, 27059.1882243533, 27403.0, 28260.85869570639, 28336.43327133487, 47010.29484557803, 48476.5152348472, 48561.0, 48607.0, 48670.5132948666, 347573.71836534835, 355659.0, 356525.0, 357578.0, 358218.0, 28948.13155605335, 28976.826737995158, 31257.218569535944, 35497.290054199286, 35994.64005359913, 34778.478322825686, 38014.239715206095, 38216.235675286895, 38264.80867595644, 38478.80760596179, 32743.836280818443, 32984.0, 33294.33411331808, 33361.66638333683, 34215.486767699, 32579.511307329936, 32583.348333033682, 32597.674023259464, 32831.0, 33042.33915321728, 32306.83846580752, 32393.676063240007, 32498.0, 32512.187195320304, 32588.511172332906, 25487.490250195264, 26284.0, 29060.418791624474, 29066.27334316659, 29360.853195733886, 22264.77735222627, 22608.208712694977, 22937.311880643607, 23048.769512305335, 23075.0], "value": 17447.990324946706, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.1220289609283, 382.58489538850347, 385.77817754791005, 385.96719278861303, 402.4024323879039, 16355.10516137736, 18296.359627413043, 18697.065146742643, 18791.248350066, 18794.060296985164, 16922.915385423086, 18136.546586335317, 18337.44987650369, 18534.814651853478, 18545.907270463664, 5162.845114646567, 5296.311479507659, 5327.041132596131, 5332.466753324676, 5336.332958380202, 3860.749051311656, 4035.61661642145, 6284.057391391305, 6297.3387794281625, 6403.359664033606, 6099.756009759604, 6327.620342779448, 6337.239531256256, 6339.492840572743, 6340.936590634104, 6224.626522408647, 6294.653794041325, 6297.0, 6309.085182648513, 6309.905351419732, 4963.305137280783, 5172.043172013152, 5228.947710522884, 5552.0, 5556.138798486241, 12463.065270104778, 12583.307918064504, 15878.126703031328, 21230.893845530827, 21626.459338516506, 2193.9780602193932, 2214.258223495131, 2221.2447767758877, 2246.168917500519, 2262.886855657227, 9653.951730241373, 9957.55191016406, 9959.800803983951, 10685.091767199798, 13577.660558486019, 1682.9663406731797, 1714.6827836850098, 1754.9645709031604, 1756.2623698046723, 1757.4201908939194, 75239.0, 77342.0, 78024.60987695082, 78140.60929695371, 79326.20673793246, 10367.792644147226, 10496.842547361795, 10528.526216320284, 10567.841482377771, 10697.625583104555, 14548.199849008406, 14589.781153282709, 14591.708165836624, 14599.927000365142, 14603.853961460462, 6714.697838597275, 6716.731330746813, 6906.447484201251, 6921.965390173118, 6961.79114626562, 5945.464908158287, 5988.760449582055, 6146.938530614726, 6147.66187859672, 6156.107364432132, 4450.621697155778, 4452.821887124479, 4491.865244042684, 4502.0, 4583.885402864888, 1674.3218996306516, 1792.8476079533125, 1804.0, 1829.6980998135425, 1839.8160183981763, 778.6262593954933, 886.3219636977717, 891.9955400222957, 897.8473659477904, 920.2913756407662, 17422.11826328593, 17641.647167056588, 17854.464366069038, 18537.629247414978, 18795.624087518172, 903.5256490342623, 906.6146887572887, 907.945523268606, 912.0788004115891, 929.9070092990647, 9644.324897257125, 9887.901120988841, 10143.695689129338, 10334.689959301233, 10784.676459706221, 461160.0, 468690.0, 475161.0, 477820.0, 482151.0, 86518.56740716255, 87882.12117878739, 88501.0, 89388.0, 93401.0659893406, 1000.2797985450464, 1000.7798284377425, 1025.3130402630106, 1027.111548510548, 1028.4138041316378, 16293.266802993656, 16326.510204693877, 16668.833311666727, 16941.830581694518, 17044.48866534006, 40230.798846005586, 40954.38568421416, 40986.0, 41291.1741765157, 43526.78236608923, 55363.0, 56716.0, 57122.14316785168, 58445.0, 58964.0, 7020.859582808213, 7883.408744344082, 8013.3188678960605, 8110.594470276581, 8279.840822284765, 11830.881691182978, 12578.245305281713, 12787.0, 12882.806757898452, 13196.406161722938, 10265.794684106426, 10292.742681432725, 10472.214583906085, 10652.414117223627, 10711.732206694895, 10907.836382454429, 11125.44372781374, 11146.554137834395, 11240.494177762184, 11246.83129753038, 10657.005698773404, 10703.892961070289, 11195.552177912792, 11243.943780281046, 11405.486753096297, 7161.0, 7165.928340716735, 7215.71137154529, 7267.963660181666, 7576.090869095744, 10448.477576121315, 10636.202284828514, 10695.572177112828, 11521.078313735048, 11601.839816018331], "value": 8647.7056037349, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1356.7557839588874, 1361.3669643615717, 1368.1449094316054, 1370.9314534273283, 1371.972560548789, 7095.077639906812, 7527.322540971311, 7572.469927105098, 7573.166951635316, 7579.73470928517, 6543.509236807235, 6705.094812200364, 6930.203026651937, 7106.289371062891, 7388.298111679382, 2189.485470914338, 2234.653628687548, 2235.474663454087, 2235.765244649313, 2239.9552008959813, 2043.4584835018657, 2085.228465467779, 2089.676100204471, 2091.905864236113, 2092.3095378525127, 1891.2624076610064, 1923.0480911948534, 2120.204923153817, 2137.5190582119053, 2179.1501314487364, 1997.2111016148613, 2001.7297664815283, 2014.0735261779598, 2015.2644284835928, 2020.0404807716363, 2039.225094464109, 2067.648499755045, 2075.3358925143807, 2088.9477763055893, 2130.2544109561686, 7458.962705186494, 7463.4029277657655, 7522.097348318182, 7523.322900938887, 7533.886991695129, 4344.391785150082, 4482.0139569295025, 4487.371767952489, 4488.079943611552, 4489.124620698965, 2814.591884176783, 2974.375381169957, 2978.970210297891, 3021.5165573508134, 3061.785675002751, 1111.3554138599593, 1152.394992628868, 1166.6383421139474, 1191.154280460874, 1211.660734994203, 10002.399856008662, 10020.098191162757, 10037.197024238043, 10039.14667253277, 10044.99550044997, 3971.7361104170345, 4124.175164966959, 4145.730527515701, 4199.097194103221, 4202.852900148541, 8542.316614670935, 8542.40203185771, 8546.359023073295, 8560.61477233526, 8567.871481927776, 4613.976930115328, 4623.907521849612, 4683.765811709401, 4685.554872287127, 4694.694844835075, 3681.3738467609382, 3699.1491956849536, 4021.5174179098112, 4242.427272318259, 4267.445232119867, 3460.567429071366, 3496.650334966483, 3597.1906321078072, 3616.27674465108, 3628.2380700053286, 1152.464104191555, 1175.6766889105565, 1190.14309697018, 1193.7552801675636, 1194.5460724924474, 761.4479502360855, 835.052215735145, 897.6947837735202, 898.8427025270682, 906.428949761646, 5101.617378696613, 5132.101882170605, 5135.152699804565, 5194.870128246748, 5311.468853114658, 919.6965001549472, 935.0929598289648, 940.9952950235205, 944.5702205496483, 981.1169947047572, 3505.5618047744033, 3600.6039335673577, 3647.6717095461536, 3657.341678497896, 3760.3231418344412, 8470.534120623302, 8559.400841941004, 8771.386002979858, 8779.25376343018, 9050.27597792175, 9013.324000699973, 9015.63937442508, 9016.278697704169, 9016.774580635405, 9026.18764311215, 6727.125473688487, 6990.685419156151, 7046.894296585555, 7055.929440705528, 7064.470164737665, 5062.886165043685, 5249.921251181312, 5323.893522129459, 5332.520073193431, 5564.4713752193475, 8178.591070446573, 8191.303739182236, 8195.836083278182, 8226.465279756796, 8240.917590824254, 8207.507549547046, 8309.210624990616, 8340.457870238415, 8344.874826877724, 8429.157084291523, 5723.255976723, 5874.706264686834, 6402.103705481143, 6545.738170473128, 6552.6723663817575, 6795.38841504267, 6978.511504194657, 7033.191183014019, 7207.603581803051, 7218.927810721825, 6283.120363149254, 6330.651814150266, 6334.524910631813, 6516.869662606816, 6521.608703477807, 6169.598976066542, 6180.443760061616, 6185.226846644169, 6202.379762023762, 6245.0632405139595, 5747.913781293368, 5834.03738383162, 5834.912476312774, 5839.620424672383, 5842.912356314574, 4423.0, 4467.8212871484775, 4472.485664148665, 4508.616767574662, 4522.954770452254, 4442.955570444255, 4457.734969922578, 4558.9772051139535, 4653.139169253699, 4703.647226458098], "value": 4020.355636857847, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.86496333948094, 343.6391788621946, 351.6747009016659, 352.43610223642173, 353.4662659384329, 4821.0, 4844.903101937959, 4857.757112144396, 4870.464248932614, 4940.0, 4843.515648435155, 4855.53872382124, 4867.318575399447, 4873.658843880929, 4885.584725298354, 3710.3692372296705, 3809.56190038145, 3821.617838216184, 3859.826307816141, 3869.613038696136, 3859.619332058106, 3879.2047630235734, 3883.689304855605, 3894.201688653819, 3894.3768996960493, 3846.826892789831, 3856.151646637735, 3861.343571592836, 3872.206197729473, 3886.6696330811774, 3716.6283371662753, 3795.8291876865605, 3804.752691075071, 3869.226154769029, 3881.9805900970455, 3462.515247865301, 3476.617572067071, 3487.4071407860724, 3494.702950249232, 3496.965030349689, 4681.976590117028, 4689.953100468986, 4713.858584242444, 4730.266808644666, 4747.406574178228, 4287.49937521868, 4429.13631841791, 4432.73403595782, 4439.422875026258, 4462.995825939171, 5069.264956581312, 5071.56891664209, 5075.923861142086, 5105.361829771278, 5117.360329958755, 3808.7524310919703, 3829.80850957451, 3841.367418847007, 3843.8654647087496, 3854.69162467002, 5126.538611524906, 5305.920411193873, 5339.0, 5340.839774806762, 5358.169483729989, 3890.455336252927, 3922.097917478996, 3927.8232479538487, 3929.7249192556246, 3929.7838618876235, 3982.900427489336, 3984.143409167043, 3986.8836725716847, 3988.1824226033596, 3998.5601583825755, 4432.955670443319, 4433.113377324484, 4447.199504089295, 4452.265376212953, 4452.888677783081, 4969.304297398367, 5082.440931497532, 5085.491450854959, 5096.490350964948, 5133.948660513422, 1339.5914246155016, 1340.4169186403751, 1347.797830325459, 1349.7368013237324, 1356.4777560639225, 914.2868562521244, 951.3150531617224, 954.8185844689486, 961.2982522758425, 967.666155176463, 4268.5913648495925, 4311.262348408783, 4406.0, 4471.642268618502, 4474.888127796831, 5175.53420192177, 5193.636445448782, 5193.844184674465, 5196.844094677166, 5207.453217412117, 4330.913381732347, 4381.101874115799, 4435.534268901783, 4456.220161471794, 4459.866204013885, 2561.743825617423, 2678.504476671822, 2689.9731002689723, 2690.9908784205923, 2720.7415295546894, 4743.699305836666, 4757.976210118996, 4762.261849413347, 4771.6898401603785, 4775.617950563947, 5139.511746384088, 5155.587552995751, 5158.92261616076, 5210.166373380241, 5264.104922227995, 4577.153226653079, 4873.366462359871, 4918.704877707349, 4927.9507204927495, 4940.333055037524, 5243.846353802158, 5250.159974404077, 5257.500537449089, 5259.921101183561, 5267.313670028389, 4966.404031516241, 5146.150885103916, 5148.330717006766, 5149.356330458692, 5171.81898633546, 4852.272159176152, 4911.140550403737, 4935.432425270996, 4946.950530494649, 4951.950480495293, 3672.540932383452, 3673.57753858299, 3687.7418580699095, 3689.133053732317, 3690.8892733218045, 5082.771275292546, 5261.710605916712, 5270.947290527046, 5278.1027225372545, 5298.523132918056, 5080.392921026113, 5118.539331460186, 5120.487951204998, 5129.384473863161, 5151.304573882478, 5108.335916330853, 5111.386633603991, 5119.769610367468, 5130.4100028497205, 5130.923036154535, 4788.904221915473, 5049.7727602257255, 5060.3168572242275, 5060.443351231288, 5075.264086707333, 4937.444704917939, 4969.304297398439, 5072.644914855925, 5124.410692770379, 5154.587632989277, 4993.176125939324, 4996.350474438445, 4997.200447928314, 5003.824866129668, 5005.599552035756], "value": 3885.2063086209855, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [674.8043067510422, 696.7387229788826, 735.1986334894964, 766.5170942306347, 778.996105019475, 12548.0, 13751.662217423038, 13753.89968802496, 13758.042020965491, 13758.793618095737, 12575.119741618068, 12662.620121396372, 12678.175918565286, 12701.110922235448, 12706.110572259922, 663.6947004377992, 681.8363592737757, 795.026093036032, 797.7367468735304, 809.5385630190793, 812.7805492517017, 830.8172202115555, 832.3258160889668, 832.8500869843426, 833.995830020852, 873.2228316798023, 873.6025108575583, 874.1739056591492, 874.567089290802, 875.0068672057197, 699.0004293859829, 718.6011763471271, 840.2983508770124, 870.9520976346298, 871.9171678690547, 636.6816591704148, 639.3798015924592, 639.8784230996096, 640.1837656987378, 640.4172203294979, 13058.673533161653, 13081.41133648988, 13083.280419576919, 13112.541061062817, 13115.344232788322, 12549.749005019848, 12600.621981340575, 12807.61577152687, 12828.127802914056, 13021.86978130216, 11927.88072119285, 12298.323592202425, 12387.504499820086, 12446.937765311206, 13094.541691040768, 3985.5217373915025, 4012.6990475714438, 4021.1756589899, 4093.85671501499, 4156.189543039109, 69082.65458672725, 69377.3062269376, 69427.65286173536, 69755.65122174357, 71302.28697713009, 10364.585416583403, 10408.271421000609, 10488.213383996079, 10512.1590272778, 10597.258191926645, 20434.489137771674, 20461.386158415273, 20468.283610073577, 20473.07871145772, 20516.692249616266, 6730.9326906731285, 6777.186737591521, 6885.483588730765, 6926.653667316614, 6993.510454268152, 3518.6481351865123, 3525.4359302511475, 3567.35787558242, 3576.499290099388, 3582.802945838004, 2920.897768578132, 2982.6122604061334, 2999.9400012000074, 3004.819710817358, 3022.969770302269, 488.80401333821254, 489.50070927654303, 489.58629957685696, 501.6739119572307, 503.14214264678634, 547.3787251469531, 549.4725063938583, 566.770457964525, 575.3527281807966, 580.561675934675, 7979.72070977513, 8041.959790201128, 8245.95877020611, 8273.296769774637, 8456.0, 501.59120316941573, 503.3230305239447, 508.47118996243495, 558.8602849287678, 576.5935015813841, 3703.9629603704157, 3724.5530536335814, 3743.1577894973957, 3781.565120011179, 3915.4126880968083, 71033.64483177551, 71481.0, 71681.2831871685, 73102.0, 73258.63370683219, 63647.681761590895, 64437.0, 64602.676986614766, 64989.350106499274, 65762.0, 43682.0, 53254.46745532495, 54195.45804541983, 54926.0, 55220.72389638107, 7551.773446796605, 7852.489588176751, 7918.841623167389, 8028.87956680662, 8032.437729358889, 38970.80514597409, 39369.40945885871, 39505.80247098746, 40222.79888600538, 40390.19219615532, 41453.378199327635, 42176.36735448909, 44003.77998109989, 45361.31958020698, 47196.7640161797, 10418.01028902253, 10503.527341269813, 10561.89438105609, 10683.198760093179, 10834.02493775564, 11527.423628818693, 11719.476468059438, 11876.990455811352, 12090.032797376365, 12118.878811211775, 10637.893621063691, 10684.626038088629, 10977.670669879917, 11061.336319820837, 11398.430078495876, 11857.229280096766, 12245.693857653274, 12842.293673848028, 12946.935265323613, 13060.0, 11477.655670329903, 11651.0, 11790.705232369259, 12411.875881241433, 12428.13003089775, 9811.656592019244, 10271.229657775846, 10544.314619549705, 10695.0, 10722.088622467178, 9009.144131307516, 9054.864177037482, 9622.711318660451, 9629.614815407585, 9802.36284641496], "value": 6391.606222124898, "unit": "score"}], "name": "dromaeo_css", "value": 6448.550923867118, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 117.0, 115.0, 116.0, 115.0, 115.0, 114.0, 116.0, 115.0, 116.0], "value": 115.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 124.0, 125.0, 160.0, 129.0, 128.0, 126.0, 121.0, 147.0, 122.0], "value": 134.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 160.0, 160.0, 161.0, 164.0, 161.0, 159.0, 160.0, 160.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 105.0, 78.0, 77.0, 76.0, 76.0, 102.0, 77.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 107.0, 85.0, 85.0, 84.0, 101.0, 85.0, 84.0, 101.0], "value": 90.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 119.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 151.0, 149.0, 148.0, 149.0, 149.0, 148.0, 149.0, 148.0], "value": 148.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 60.0, 60.0, 61.0, 61.0, 61.0, 61.0, 68.0], "value": 61.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 68.0, 68.0, 69.0, 68.0, 68.0, 68.0, 68.0, 69.0], "value": 68.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 95.0, 85.0, 88.0, 84.0, 85.0, 86.0, 85.0, 94.0, 83.0], "value": 87.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 132.0, 135.0, 131.0, 130.0, 139.0, 131.0, 138.0, 221.0, 143.0], "value": 143.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 175.0, 190.0, 174.0, 173.0, 171.0, 174.0, 175.0, 171.0, 186.0], "value": 177.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 73.0, 69.0, 69.0, 69.0, 68.0, 68.0, 72.0, 70.0, 66.0], "value": 69.2, "unit": "score"}], "name": "kraken", "value": 1549.6000000000001, "alertThreshold": 2.0}]} 15:01:45 INFO - Return code: 0 15:01:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:01:45 INFO - # TBPL SUCCESS # 15:01:45 INFO - Running post-action listener: _resource_record_post_action 15:01:45 INFO - [mozharness: 2017-01-10 23:01:45.118559Z] Finished run-tests step (success) 15:01:45 INFO - Running post-run listener: _resource_record_post_run 15:01:45 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 8192; Write bytes: 383598592; Read time: 28; Write time: 201816 15:01:45 INFO - TinderboxPrint: CPU usage
13.1% 15:01:45 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 28 15:01:45 INFO - TinderboxPrint: I/O write bytes / time
383,598,592 / 201,816 15:01:45 INFO - TinderboxPrint: CPU idle
8,338.7 (86.9%) 15:01:45 INFO - TinderboxPrint: CPU user
1,211.7 (12.6%) 15:01:45 INFO - TinderboxPrint: Swap in / out
0 / 0 15:01:45 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99344384; Read time: 0; Write time: 58040 15:01:45 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 284254208; Read time: 12; Write time: 143776 15:01:45 INFO - Running post-run listener: _upload_blobber_files 15:01:45 INFO - Blob upload gear active. 15:01:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:01:45 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 15:01:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:01:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:01:46 INFO - (blobuploader) - INFO - Open directory for files ... 15:01:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:01:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:01:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:01:47 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:01:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:01:47 INFO - (blobuploader) - INFO - Done attempting. 15:01:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:01:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:01:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:01:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:01:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:01:48 INFO - (blobuploader) - INFO - Done attempting. 15:01:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:01:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:01:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:01:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:01:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:01:49 INFO - (blobuploader) - INFO - Done attempting. 15:01:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:01:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:01:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:01:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:01:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:01:52 INFO - (blobuploader) - INFO - Done attempting. 15:01:52 INFO - (blobuploader) - INFO - Iteration through files over. 15:01:52 INFO - Return code: 0 15:01:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:01:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:01:52 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1ac73d649d3ba568045794be3103f09cff87e2dc6428ffcf51b0a134ef768e6da7d0fee117cf90924c0b4f19d9fc74815e57c3468bedde7ef57eaf86149050da", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ff2858b6b68e09347151b22a8a5bc88134b53942d2d1919740bad12c62220b73c95105f82c0355eececa654b52e37c112435e2dc73f12b0a57862a2002b8b9d2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c9faf1b8e04cd72272dcabdc9cad000c1978bc87990e803465033a500241fac8f473722bd0e3f86aa476b28e862a3510009cf9aab6894ea12a0434adb85da616", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7ead780e3f3b32e5f24da22fe747f5fe4a586c364a2862c69538d8072aeac552854016404bc149145c3be1e1339918ada8a51ff33881ee0e6d16bbab265627d9"} 15:01:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:01:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:01:52 INFO - Contents: 15:01:52 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1ac73d649d3ba568045794be3103f09cff87e2dc6428ffcf51b0a134ef768e6da7d0fee117cf90924c0b4f19d9fc74815e57c3468bedde7ef57eaf86149050da", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ff2858b6b68e09347151b22a8a5bc88134b53942d2d1919740bad12c62220b73c95105f82c0355eececa654b52e37c112435e2dc73f12b0a57862a2002b8b9d2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c9faf1b8e04cd72272dcabdc9cad000c1978bc87990e803465033a500241fac8f473722bd0e3f86aa476b28e862a3510009cf9aab6894ea12a0434adb85da616", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7ead780e3f3b32e5f24da22fe747f5fe4a586c364a2862c69538d8072aeac552854016404bc149145c3be1e1339918ada8a51ff33881ee0e6d16bbab265627d9"} 15:01:52 INFO - Running post-run listener: copy_logs_to_upload_dir 15:01:52 INFO - Copying logs to upload dir... 15:01:52 INFO - mkdir: /builds/slave/test/build/upload/logs 15:01:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.038609 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-01-10 15:01:52.667405) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-10 15:01:52.671445) ========= 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=769a0cfe1e83e11e6f11f5a3000001a8-1484088062.801529-1647687941 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-Non-PGO/sha512/1ac73d649d3ba568045794be3103f09cff87e2dc6428ffcf51b0a134ef768e6da7d0fee117cf90924c0b4f19d9fc74815e57c3468bedde7ef57eaf86149050da", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ff2858b6b68e09347151b22a8a5bc88134b53942d2d1919740bad12c62220b73c95105f82c0355eececa654b52e37c112435e2dc73f12b0a57862a2002b8b9d2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c9faf1b8e04cd72272dcabdc9cad000c1978bc87990e803465033a500241fac8f473722bd0e3f86aa476b28e862a3510009cf9aab6894ea12a0434adb85da616", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7ead780e3f3b32e5f24da22fe747f5fe4a586c364a2862c69538d8072aeac552854016404bc149145c3be1e1339918ada8a51ff33881ee0e6d16bbab265627d9"} build_url:https://queue.taskcluster.net/v1/task/EcywXawJSIuho9G_imj5qg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011802 build_url: 'https://queue.taskcluster.net/v1/task/EcywXawJSIuho9G_imj5qg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1ac73d649d3ba568045794be3103f09cff87e2dc6428ffcf51b0a134ef768e6da7d0fee117cf90924c0b4f19d9fc74815e57c3468bedde7ef57eaf86149050da", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ff2858b6b68e09347151b22a8a5bc88134b53942d2d1919740bad12c62220b73c95105f82c0355eececa654b52e37c112435e2dc73f12b0a57862a2002b8b9d2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c9faf1b8e04cd72272dcabdc9cad000c1978bc87990e803465033a500241fac8f473722bd0e3f86aa476b28e862a3510009cf9aab6894ea12a0434adb85da616", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7ead780e3f3b32e5f24da22fe747f5fe4a586c364a2862c69538d8072aeac552854016404bc149145c3be1e1339918ada8a51ff33881ee0e6d16bbab265627d9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-10 15:01:52.700851) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 15:01:52.701624) ========= 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=769a0cfe1e83e11e6f11f5a3000001a8-1484088062.801529-1647687941 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004510 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 15:01:52.785810) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-10 15:01:52.786471) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-10 15:01:52.787189) ========= ========= Total master_lag: 0.26 =========