builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-084 starttime: 1490013522.29 results: success (0) revision: 8d967436d696d1f8e3fb33cf7e3d32a72457ffa6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-20 05:38:42.292478) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-20 05:38:42.292956) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-20 05:38:42.293542) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-20 05:38:42.325918) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 05:38:42.326479) ========= 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=ea65d483da93c827905c2090000001f5-1490013442.628433-1600166000 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-20 05:38:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2017-03-20 05:38:42 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.098537 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 05:38:42.438591) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 05:38:42.438895) ========= 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=ea65d483da93c827905c2090000001f5-1490013442.628433-1600166000 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020649 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 05:38:42.487953) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-20 05:38:42.488432) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8d967436d696d1f8e3fb33cf7e3d32a72457ffa6 --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 8d967436d696d1f8e3fb33cf7e3d32a72457ffa6 --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=ea65d483da93c827905c2090000001f5-1490013442.628433-1600166000 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-20 05:38:42,786 truncating revision to first 12 chars 2017-03-20 05:38:42,786 Setting DEBUG logging. 2017-03-20 05:38:42,786 attempt 1/10 2017-03-20 05:38:42,786 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8d967436d696?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-20 05:38:44,115 unpacking tar archive at: mozilla-central-8d967436d696/testing/mozharness/ program finished with exit code 0 elapsedTime=1.615319 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-20 05:38:44.117415) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-20 05:38:44.117694) ========= script_repo_revision: 8d967436d696d1f8e3fb33cf7e3d32a72457ffa6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-20 05:38:44.118049) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-20 05:38:44.118321) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-20 05:38:44.126752) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-03-20 05:38:44.127035) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=ea65d483da93c827905c2090000001f5-1490013442.628433-1600166000 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:38:44 INFO - MultiFileLogger online at 20170320 05:38:44 in /builds/slave/test 05:38:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 05:38:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:38:44 INFO - {'append_to_log': False, 05:38:44 INFO - 'base_work_dir': '/builds/slave/test', 05:38:44 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 05:38:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:38:44 INFO - 'branch': 'Firefox-Non-PGO', 05:38:44 INFO - 'buildbot_json_path': 'buildprops.json', 05:38:44 INFO - 'config_files': ('talos/linux_config.py',), 05:38:44 INFO - 'default_actions': ('clobber', 05:38:44 INFO - 'read-buildbot-config', 05:38:44 INFO - 'download-and-extract', 05:38:44 INFO - 'populate-webroot', 05:38:44 INFO - 'create-virtualenv', 05:38:44 INFO - 'install', 05:38:44 INFO - 'run-tests'), 05:38:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:38:44 INFO - 'download_minidump_stackwalk': True, 05:38:44 INFO - 'download_symbols': 'ondemand', 05:38:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:38:44 INFO - 'tooltool.py': '/tools/tooltool.py', 05:38:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:38:44 INFO - '/tools/misc-python/virtualenv.py')}, 05:38:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:38:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:38:44 INFO - 'gecko_profile': False, 05:38:44 INFO - 'gecko_profile_interval': 0, 05:38:44 INFO - 'installer_path': 'installer.exe', 05:38:44 INFO - 'log_level': 'info', 05:38:44 INFO - 'log_name': 'talos', 05:38:44 INFO - 'log_to_console': True, 05:38:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:38:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:38:44 INFO - 'opt_config_files': (), 05:38:44 INFO - 'pip_index': False, 05:38:44 INFO - 'suite': 'dromaeojs-e10s', 05:38:44 INFO - 'system_bits': '32', 05:38:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:38:44 INFO - 'title': 'talos-linux64-ix-084', 05:38:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:38:44 INFO - 'use_talos_json': True, 05:38:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:38:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:38:44 INFO - 'work_dir': 'build'} 05:38:44 INFO - [mozharness: 2017-03-20 12:38:44.519525Z] Running clobber step. 05:38:44 INFO - Running pre-action listener: _resource_record_pre_action 05:38:44 INFO - Running main action method: clobber 05:38:44 INFO - rmtree: /builds/slave/test/build 05:38:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:38:45 INFO - Running post-action listener: _resource_record_post_action 05:38:45 INFO - [mozharness: 2017-03-20 12:38:45.980025Z] Finished clobber step (success) 05:38:45 INFO - [mozharness: 2017-03-20 12:38:45.980123Z] Running read-buildbot-config step. 05:38:45 INFO - Running pre-action listener: _resource_record_pre_action 05:38:45 INFO - Running main action method: read_buildbot_config 05:38:45 INFO - Using buildbot properties: 05:38:45 INFO - { 05:38:45 INFO - "project": "", 05:38:45 INFO - "product": "firefox", 05:38:45 INFO - "who": "cbook@mozilla.com", 05:38:45 INFO - "installer_path": "public/build/target.tar.bz2", 05:38:45 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:38:45 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 05:38:45 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 05:38:45 INFO - "stage_platform": "linux64", 05:38:45 INFO - "basedir": "/builds/slave/test", 05:38:45 INFO - "buildnumber": 726, 05:38:45 INFO - "platform": "ubuntu64_hw", 05:38:45 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:38:45 INFO - "slavebuilddir": "test", 05:38:45 INFO - "taskId": "SaWpRqYFS8q7_r0GJSiRaA", 05:38:45 INFO - "branch": "mozilla-central", 05:38:45 INFO - "script_repo_revision": "production", 05:38:45 INFO - "revision": "8d967436d696d1f8e3fb33cf7e3d32a72457ffa6", 05:38:45 INFO - "slavename": "talos-linux64-ix-084", 05:38:45 INFO - "repo_path": "mozilla-central" 05:38:45 INFO - } 05:38:45 INFO - Finding installer, test and symbols from parent task. 05:38:45 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SaWpRqYFS8q7_r0GJSiRaA'}, attempt #1 05:38:46 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SaWpRqYFS8q7_r0GJSiRaA'}, attempt #1 05:38:46 INFO - Task dependencies: IsQj73FnScWDCarTb52gqQ 05:38:46 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IsQj73FnScWDCarTb52gqQ'}, attempt #1 05:38:47 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/IsQj73FnScWDCarTb52gqQ/artifacts/public/build/target.tar.bz2 05:38:47 INFO - Set test_url: https://queue.taskcluster.net/v1/task/IsQj73FnScWDCarTb52gqQ/artifacts/public/build/test_packages.json 05:38:47 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/IsQj73FnScWDCarTb52gqQ/artifacts/public/build/target.crashreporter-symbols.zip 05:38:47 INFO - Running post-action listener: _resource_record_post_action 05:38:47 INFO - [mozharness: 2017-03-20 12:38:47.424228Z] Finished read-buildbot-config step (success) 05:38:47 INFO - [mozharness: 2017-03-20 12:38:47.424443Z] Running download-and-extract step. 05:38:47 INFO - Running pre-action listener: _resource_record_pre_action 05:38:47 INFO - Running main action method: download_and_extract 05:38:47 INFO - mkdir: /builds/slave/test/build/tests 05:38:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:38:47 INFO - trying https://queue.taskcluster.net/v1/task/IsQj73FnScWDCarTb52gqQ/artifacts/public/build/target.test_packages.json 05:38:47 INFO - Downloading https://queue.taskcluster.net/v1/task/IsQj73FnScWDCarTb52gqQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:38:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IsQj73FnScWDCarTb52gqQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:38:47 INFO - Downloaded 986 bytes. 05:38:47 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:38:47 INFO - Using the following test package requirements: 05:38:47 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 05:38:47 INFO - u'common': [u'target.common.tests.zip'], 05:38:47 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:38:47 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:38:47 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:38:47 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:38:47 INFO - u'mozbase': [u'target.common.tests.zip'], 05:38:47 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:38:47 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:38:47 INFO - u'web-platform': [u'target.common.tests.zip', 05:38:47 INFO - u'target.web-platform.tests.zip'], 05:38:47 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:38:47 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 05:38:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IsQj73FnScWDCarTb52gqQ/artifacts/public/build/target.common.tests.zip 05:38:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IsQj73FnScWDCarTb52gqQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:38:47 INFO - Fetch https://queue.taskcluster.net/v1/task/IsQj73FnScWDCarTb52gqQ/artifacts/public/build/target.common.tests.zip into memory 05:38:49 INFO - Expected file size: 58188917 05:38:49 INFO - Obtained file size: 58188917 05:38:58 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 05:38:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IsQj73FnScWDCarTb52gqQ/artifacts/public/build/target.common.tests.zip 05:38:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IsQj73FnScWDCarTb52gqQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:38:58 INFO - Fetch https://queue.taskcluster.net/v1/task/IsQj73FnScWDCarTb52gqQ/artifacts/public/build/target.common.tests.zip into memory 05:39:00 INFO - Expected file size: 58188917 05:39:00 INFO - Obtained file size: 58188917 05:39:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IsQj73FnScWDCarTb52gqQ/artifacts/public/build/target.talos.tests.zip 05:39:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IsQj73FnScWDCarTb52gqQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:39:10 INFO - Fetch https://queue.taskcluster.net/v1/task/IsQj73FnScWDCarTb52gqQ/artifacts/public/build/target.talos.tests.zip into memory 05:39:11 INFO - Expected file size: 14404171 05:39:11 INFO - Obtained file size: 14404171 05:39:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:11 INFO - trying https://queue.taskcluster.net/v1/task/IsQj73FnScWDCarTb52gqQ/artifacts/public/build/target.tar.bz2 05:39:11 INFO - Downloading https://queue.taskcluster.net/v1/task/IsQj73FnScWDCarTb52gqQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:39:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IsQj73FnScWDCarTb52gqQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:39:12 INFO - Downloaded 61842464 bytes. 05:39:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IsQj73FnScWDCarTb52gqQ/artifacts/public/build/target.tar.bz2 05:39:12 INFO - mkdir: /builds/slave/test/properties 05:39:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:39:12 INFO - Writing to file /builds/slave/test/properties/build_url 05:39:12 INFO - Contents: 05:39:12 INFO - build_url:https://queue.taskcluster.net/v1/task/IsQj73FnScWDCarTb52gqQ/artifacts/public/build/target.tar.bz2 05:39:12 INFO - Running post-action listener: _resource_record_post_action 05:39:12 INFO - Running post-action listener: set_extra_try_arguments 05:39:12 INFO - [mozharness: 2017-03-20 12:39:12.727855Z] Finished download-and-extract step (success) 05:39:12 INFO - [mozharness: 2017-03-20 12:39:12.727977Z] Running populate-webroot step. 05:39:12 INFO - Running pre-action listener: _resource_record_pre_action 05:39:12 INFO - Running main action method: populate_webroot 05:39:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:39:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:39:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:39:12 INFO - '--tppagecycles', 05:39:12 INFO - '7'], 05:39:12 INFO - 'tests': ['tsvgm']}}, 05:39:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:39:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:39:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:39:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:39:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:39:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:39:12 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:39:12 INFO - 'talos_options': ['--disable-e10s'], 05:39:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:39:12 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:39:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:39:12 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:39:12 INFO - 'talos_options': ['--disable-e10s'], 05:39:12 INFO - 'tests': ['damp', 'tps']}, 05:39:12 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:39:12 INFO - 'tests': ['damp', 'tps']}, 05:39:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:39:12 INFO - 'tests': ['dromaeo_dom']}, 05:39:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:39:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:39:12 INFO - 'tests': ['basic_compositor_video']}, 05:39:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:39:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:39:12 INFO - 'tests': ['a11yr', 05:39:12 INFO - 'ts_paint', 05:39:12 INFO - 'tpaint', 05:39:12 INFO - 'sessionrestore', 05:39:12 INFO - 'sessionrestore_no_auto_restore', 05:39:12 INFO - 'tabpaint']}, 05:39:12 INFO - 'other-e10s': {'tests': ['a11yr', 05:39:12 INFO - 'ts_paint', 05:39:12 INFO - 'tpaint', 05:39:12 INFO - 'sessionrestore', 05:39:12 INFO - 'sessionrestore_no_auto_restore', 05:39:12 INFO - 'tabpaint']}, 05:39:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:39:12 INFO - 'ts_paint', 05:39:12 INFO - 'tpaint', 05:39:12 INFO - 'sessionrestore', 05:39:12 INFO - 'sessionrestore_no_auto_restore', 05:39:12 INFO - 'tabpaint']}, 05:39:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:39:12 INFO - 'ts_paint', 05:39:12 INFO - 'tpaint', 05:39:12 INFO - 'sessionrestore', 05:39:12 INFO - 'sessionrestore_no_auto_restore', 05:39:12 INFO - 'tabpaint']}, 05:39:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:39:12 INFO - 'tests': ['a11yr', 05:39:12 INFO - 'ts_paint', 05:39:12 INFO - 'tpaint', 05:39:12 INFO - 'sessionrestore', 05:39:12 INFO - 'sessionrestore_no_auto_restore', 05:39:12 INFO - 'tabpaint']}, 05:39:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:39:12 INFO - 'tests': ['a11yr', 05:39:12 INFO - 'ts_paint', 05:39:12 INFO - 'tpaint', 05:39:12 INFO - 'sessionrestore', 05:39:12 INFO - 'sessionrestore_no_auto_restore', 05:39:12 INFO - 'tabpaint']}, 05:39:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:39:12 INFO - 'tests': ['tsvgx', 05:39:12 INFO - 'tsvgr_opacity', 05:39:12 INFO - 'tart', 05:39:12 INFO - 'tscrollx', 05:39:12 INFO - 'cart', 05:39:12 INFO - 'tsvg_static']}, 05:39:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:39:12 INFO - 'tsvgr_opacity', 05:39:12 INFO - 'tart', 05:39:12 INFO - 'tscrollx', 05:39:12 INFO - 'cart', 05:39:12 INFO - 'tsvg_static']}, 05:39:12 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:39:12 INFO - 'talos_options': ['--disable-e10s'], 05:39:12 INFO - 'tests': ['tp5o']}, 05:39:12 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:39:12 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:39:12 INFO - 'talos_options': ['--disable-e10s', 05:39:12 INFO - '--xperf_path', 05:39:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:39:12 INFO - 'tests': ['tp5n']}, 05:39:12 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:39:12 INFO - 'talos_options': ['--xperf_path', 05:39:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:39:12 INFO - 'tests': ['tp5n']}}, 05:39:12 INFO - 'talos.zip': {'path': '', 05:39:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:39:12 INFO - Running post-action listener: _resource_record_post_action 05:39:12 INFO - [mozharness: 2017-03-20 12:39:12.743789Z] Finished populate-webroot step (success) 05:39:12 INFO - [mozharness: 2017-03-20 12:39:12.743878Z] Running create-virtualenv step. 05:39:12 INFO - Running pre-action listener: _resource_record_pre_action 05:39:12 INFO - Running main action method: create_virtualenv 05:39:12 INFO - Creating virtualenv /builds/slave/test/build/venv 05:39:12 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 05:39:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:39:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:39:12 INFO - Using real prefix '/usr' 05:39:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:39:13 INFO - Installing distribute.............................................................................................................................................................................................done. 05:39:15 INFO - Installing pip.................done. 05:39:15 INFO - Return code: 0 05:39:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:39:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:39:15 INFO - Reading from file tmpfile_stdout 05:39:15 INFO - Output received: 05:39:15 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 05:39:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:39:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:15 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 0x14921f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x172fb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172d290>, '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 0x172db90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x172e040>, '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': 'ea65d483da93c827905c2090000001f5-1490013442.628433-1600166000', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:39:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:39:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:39:15 INFO - Using env: {'DISPLAY': ':0', 05:39:15 INFO - 'HOME': '/home/cltbld', 05:39:15 INFO - 'LANG': 'en_US.UTF-8', 05:39:15 INFO - 'LANGUAGE': 'en_US:en', 05:39:15 INFO - 'LOGNAME': 'cltbld', 05:39:15 INFO - 'MAIL': '/var/mail/cltbld', 05:39:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:15 INFO - 'MOZ_NO_REMOTE': '1', 05:39:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:15 INFO - 'NO_EM_RESTART': '1', 05:39:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:15 INFO - 'PWD': '/builds/slave/test', 05:39:15 INFO - 'SHELL': '/bin/bash', 05:39:15 INFO - 'SHLVL': '1', 05:39:15 INFO - 'TERM': 'linux', 05:39:15 INFO - 'TMOUT': '86400', 05:39:15 INFO - 'USER': 'cltbld', 05:39:15 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1490013442.628433-1600166000', 05:39:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:15 INFO - '_': '/tools/buildbot/bin/python'} 05:39:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:15 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:39:15 INFO - Cleaning up... 05:39:15 INFO - Return code: 0 05:39:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:39:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:15 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 0x14921f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x172fb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172d290>, '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 0x172db90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x172e040>, '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': 'ea65d483da93c827905c2090000001f5-1490013442.628433-1600166000', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:39:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:39:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:39:15 INFO - Using env: {'DISPLAY': ':0', 05:39:15 INFO - 'HOME': '/home/cltbld', 05:39:15 INFO - 'LANG': 'en_US.UTF-8', 05:39:15 INFO - 'LANGUAGE': 'en_US:en', 05:39:15 INFO - 'LOGNAME': 'cltbld', 05:39:15 INFO - 'MAIL': '/var/mail/cltbld', 05:39:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:15 INFO - 'MOZ_NO_REMOTE': '1', 05:39:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:15 INFO - 'NO_EM_RESTART': '1', 05:39:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:15 INFO - 'PWD': '/builds/slave/test', 05:39:15 INFO - 'SHELL': '/bin/bash', 05:39:15 INFO - 'SHLVL': '1', 05:39:15 INFO - 'TERM': 'linux', 05:39:15 INFO - 'TMOUT': '86400', 05:39:15 INFO - 'USER': 'cltbld', 05:39:15 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1490013442.628433-1600166000', 05:39:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:15 INFO - '_': '/tools/buildbot/bin/python'} 05:39:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:16 INFO - Downloading/unpacking psutil>=3.1.1 05:39:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:39:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:39:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:39:18 INFO - Installing collected packages: psutil 05:39:18 INFO - Running setup.py install for psutil 05:39:18 INFO - building 'psutil._psutil_linux' extension 05:39:18 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:39:18 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:39:18 INFO - building 'psutil._psutil_posix' extension 05:39:18 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:39:18 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:39:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:39:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:39:18 INFO - Successfully installed psutil 05:39:18 INFO - Cleaning up... 05:39:18 INFO - Return code: 0 05:39:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:39: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')]} 05:39:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39: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')]} 05:39:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14921f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x172fb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172d290>, '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 0x172db90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x172e040>, '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': 'ea65d483da93c827905c2090000001f5-1490013442.628433-1600166000', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:39:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:39:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:39:18 INFO - Using env: {'DISPLAY': ':0', 05:39:18 INFO - 'HOME': '/home/cltbld', 05:39:18 INFO - 'LANG': 'en_US.UTF-8', 05:39:18 INFO - 'LANGUAGE': 'en_US:en', 05:39:18 INFO - 'LOGNAME': 'cltbld', 05:39:18 INFO - 'MAIL': '/var/mail/cltbld', 05:39:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:18 INFO - 'MOZ_NO_REMOTE': '1', 05:39:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:18 INFO - 'NO_EM_RESTART': '1', 05:39:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:18 INFO - 'PWD': '/builds/slave/test', 05:39:18 INFO - 'SHELL': '/bin/bash', 05:39:18 INFO - 'SHLVL': '1', 05:39:18 INFO - 'TERM': 'linux', 05:39:18 INFO - 'TMOUT': '86400', 05:39:18 INFO - 'USER': 'cltbld', 05:39:18 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1490013442.628433-1600166000', 05:39:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:18 INFO - '_': '/tools/buildbot/bin/python'} 05:39:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:39:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:39:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:39:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:39:20 INFO - Installing collected packages: mozsystemmonitor 05:39:20 INFO - Running setup.py install for mozsystemmonitor 05:39:21 INFO - Successfully installed mozsystemmonitor 05:39:21 INFO - Cleaning up... 05:39:21 INFO - Return code: 0 05:39:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:39:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:21 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 0x14921f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x172fb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172d290>, '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 0x172db90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x172e040>, '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': 'ea65d483da93c827905c2090000001f5-1490013442.628433-1600166000', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:39:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:39:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:39:21 INFO - Using env: {'DISPLAY': ':0', 05:39:21 INFO - 'HOME': '/home/cltbld', 05:39:21 INFO - 'LANG': 'en_US.UTF-8', 05:39:21 INFO - 'LANGUAGE': 'en_US:en', 05:39:21 INFO - 'LOGNAME': 'cltbld', 05:39:21 INFO - 'MAIL': '/var/mail/cltbld', 05:39:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:21 INFO - 'MOZ_NO_REMOTE': '1', 05:39:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:21 INFO - 'NO_EM_RESTART': '1', 05:39:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:21 INFO - 'PWD': '/builds/slave/test', 05:39:21 INFO - 'SHELL': '/bin/bash', 05:39:21 INFO - 'SHLVL': '1', 05:39:21 INFO - 'TERM': 'linux', 05:39:21 INFO - 'TMOUT': '86400', 05:39:21 INFO - 'USER': 'cltbld', 05:39:21 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1490013442.628433-1600166000', 05:39:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:21 INFO - '_': '/tools/buildbot/bin/python'} 05:39:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:21 INFO - Downloading/unpacking jsonschema==2.5.1 05:39:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:39:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:39:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:23 INFO - Downloading functools32-3.2.3-2.tar.gz 05:39:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:39:23 INFO - warning: no files found matching '*.txt' 05:39:23 INFO - no previously-included directories found matching 'build' 05:39:23 INFO - no previously-included directories found matching 'dist' 05:39:23 INFO - no previously-included directories found matching '.git*' 05:39:23 INFO - Installing collected packages: jsonschema, functools32 05:39:23 INFO - Running setup.py install for functools32 05:39:23 INFO - warning: no files found matching '*.txt' 05:39:23 INFO - no previously-included directories found matching 'build' 05:39:23 INFO - no previously-included directories found matching 'dist' 05:39:23 INFO - no previously-included directories found matching '.git*' 05:39:23 INFO - Successfully installed jsonschema functools32 05:39:23 INFO - Cleaning up... 05:39:23 INFO - Return code: 0 05:39:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:39:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:23 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 0x14921f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x172fb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172d290>, '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 0x172db90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x172e040>, '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': 'ea65d483da93c827905c2090000001f5-1490013442.628433-1600166000', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:39:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:39:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:39:23 INFO - Using env: {'DISPLAY': ':0', 05:39:23 INFO - 'HOME': '/home/cltbld', 05:39:23 INFO - 'LANG': 'en_US.UTF-8', 05:39:23 INFO - 'LANGUAGE': 'en_US:en', 05:39:23 INFO - 'LOGNAME': 'cltbld', 05:39:23 INFO - 'MAIL': '/var/mail/cltbld', 05:39:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:23 INFO - 'MOZ_NO_REMOTE': '1', 05:39:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:23 INFO - 'NO_EM_RESTART': '1', 05:39:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:23 INFO - 'PWD': '/builds/slave/test', 05:39:23 INFO - 'SHELL': '/bin/bash', 05:39:23 INFO - 'SHLVL': '1', 05:39:23 INFO - 'TERM': 'linux', 05:39:23 INFO - 'TMOUT': '86400', 05:39:23 INFO - 'USER': 'cltbld', 05:39:23 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1490013442.628433-1600166000', 05:39:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:23 INFO - '_': '/tools/buildbot/bin/python'} 05:39:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:39:24 INFO - Cleaning up... 05:39:24 INFO - Return code: 0 05:39:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:39:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:24 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 0x14921f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x172fb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172d290>, '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 0x172db90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x172e040>, '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': 'ea65d483da93c827905c2090000001f5-1490013442.628433-1600166000', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:39:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:39:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:39:24 INFO - Using env: {'DISPLAY': ':0', 05:39:24 INFO - 'HOME': '/home/cltbld', 05:39:24 INFO - 'LANG': 'en_US.UTF-8', 05:39:24 INFO - 'LANGUAGE': 'en_US:en', 05:39:24 INFO - 'LOGNAME': 'cltbld', 05:39:24 INFO - 'MAIL': '/var/mail/cltbld', 05:39:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:24 INFO - 'MOZ_NO_REMOTE': '1', 05:39:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:24 INFO - 'NO_EM_RESTART': '1', 05:39:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:24 INFO - 'PWD': '/builds/slave/test', 05:39:24 INFO - 'SHELL': '/bin/bash', 05:39:24 INFO - 'SHLVL': '1', 05:39:24 INFO - 'TERM': 'linux', 05:39:24 INFO - 'TMOUT': '86400', 05:39:24 INFO - 'USER': 'cltbld', 05:39:24 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1490013442.628433-1600166000', 05:39:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:24 INFO - '_': '/tools/buildbot/bin/python'} 05:39:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:24 INFO - Downloading/unpacking blobuploader==1.2.4 05:39:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:26 INFO - Downloading blobuploader-1.2.4.tar.gz 05:39:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:39:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:39:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:39:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:39:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:27 INFO - Downloading docopt-0.6.1.tar.gz 05:39:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:39:27 INFO - Installing collected packages: blobuploader, requests, docopt 05:39:27 INFO - Running setup.py install for blobuploader 05:39:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:39:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:39:27 INFO - Running setup.py install for requests 05:39:27 INFO - Running setup.py install for docopt 05:39:27 INFO - Successfully installed blobuploader requests docopt 05:39:27 INFO - Cleaning up... 05:39:27 INFO - Return code: 0 05:39:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:39:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:27 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 0x14921f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x172fb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172d290>, '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 0x172db90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x172e040>, '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': 'ea65d483da93c827905c2090000001f5-1490013442.628433-1600166000', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:39:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:39:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:39:27 INFO - Using env: {'DISPLAY': ':0', 05:39:27 INFO - 'HOME': '/home/cltbld', 05:39:27 INFO - 'LANG': 'en_US.UTF-8', 05:39:27 INFO - 'LANGUAGE': 'en_US:en', 05:39:27 INFO - 'LOGNAME': 'cltbld', 05:39:27 INFO - 'MAIL': '/var/mail/cltbld', 05:39:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:27 INFO - 'MOZ_NO_REMOTE': '1', 05:39:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:27 INFO - 'NO_EM_RESTART': '1', 05:39:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:27 INFO - 'PWD': '/builds/slave/test', 05:39:27 INFO - 'SHELL': '/bin/bash', 05:39:27 INFO - 'SHLVL': '1', 05:39:27 INFO - 'TERM': 'linux', 05:39:27 INFO - 'TMOUT': '86400', 05:39:27 INFO - 'USER': 'cltbld', 05:39:27 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1490013442.628433-1600166000', 05:39:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:27 INFO - '_': '/tools/buildbot/bin/python'} 05:39:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:39:27 INFO - Running setup.py (path:/tmp/pip-U1aZA3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:39:28 INFO - Running setup.py (path:/tmp/pip-hcnOqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:39:28 INFO - Running setup.py (path:/tmp/pip-yExEjb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:39:28 INFO - Running setup.py (path:/tmp/pip-N8HIFA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:39:28 INFO - Running setup.py (path:/tmp/pip-nCn8Oi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:39:28 INFO - Running setup.py (path:/tmp/pip-NADsyC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:39:28 INFO - Running setup.py (path:/tmp/pip-sGsrrC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:39:28 INFO - Running setup.py (path:/tmp/pip-5YeWeX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:39:28 INFO - Running setup.py (path:/tmp/pip-RLmIkk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:39:28 INFO - Running setup.py (path:/tmp/pip-7CQm6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:39:28 INFO - Running setup.py (path:/tmp/pip-4gkNX9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:39:28 INFO - Running setup.py (path:/tmp/pip-lCGdgQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:39:28 INFO - Running setup.py (path:/tmp/pip-U5EwRP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:39:28 INFO - Running setup.py (path:/tmp/pip-_mQrnh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:39:28 INFO - Running setup.py (path:/tmp/pip-31ppu4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:39:29 INFO - Running setup.py (path:/tmp/pip-ifty1o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:39:29 INFO - Running setup.py (path:/tmp/pip-emoxaO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:39:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:39:29 INFO - Running setup.py install for manifestparser 05:39:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:39:29 INFO - Running setup.py install for mozcrash 05:39:29 INFO - Running setup.py install for mozdebug 05:39:29 INFO - Running setup.py install for mozdevice 05:39:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:39:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:39:29 INFO - Running setup.py install for mozfile 05:39:29 INFO - Running setup.py install for mozhttpd 05:39:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:39:29 INFO - Running setup.py install for mozinfo 05:39:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:39:29 INFO - Running setup.py install for mozInstall 05:39:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:39:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:39:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:39:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:39:30 INFO - Running setup.py install for mozleak 05:39:30 INFO - Running setup.py install for mozlog 05:39:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:39:30 INFO - Running setup.py install for moznetwork 05:39:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:39:30 INFO - Running setup.py install for mozprocess 05:39:30 INFO - Running setup.py install for mozprofile 05:39:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:39:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:39:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:39:30 INFO - Running setup.py install for mozrunner 05:39:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:39:30 INFO - Running setup.py install for mozscreenshot 05:39:30 INFO - Running setup.py install for moztest 05:39:30 INFO - Running setup.py install for mozversion 05:39:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:39:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:39:31 INFO - Cleaning up... 05:39:31 INFO - Return code: 0 05:39:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:39: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')]} 05:39:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39: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')]} 05:39:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:31 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 0x14921f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x172fb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172d290>, '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 0x172db90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x172e040>, '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': 'ea65d483da93c827905c2090000001f5-1490013442.628433-1600166000', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:39:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:39:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:39:31 INFO - Using env: {'DISPLAY': ':0', 05:39:31 INFO - 'HOME': '/home/cltbld', 05:39:31 INFO - 'LANG': 'en_US.UTF-8', 05:39:31 INFO - 'LANGUAGE': 'en_US:en', 05:39:31 INFO - 'LOGNAME': 'cltbld', 05:39:31 INFO - 'MAIL': '/var/mail/cltbld', 05:39:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:31 INFO - 'MOZ_NO_REMOTE': '1', 05:39:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:31 INFO - 'NO_EM_RESTART': '1', 05:39:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:31 INFO - 'PWD': '/builds/slave/test', 05:39:31 INFO - 'SHELL': '/bin/bash', 05:39:31 INFO - 'SHLVL': '1', 05:39:31 INFO - 'TERM': 'linux', 05:39:31 INFO - 'TMOUT': '86400', 05:39:31 INFO - 'USER': 'cltbld', 05:39:31 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1490013442.628433-1600166000', 05:39:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:31 INFO - '_': '/tools/buildbot/bin/python'} 05:39:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:39:31 INFO - Running setup.py (path:/tmp/pip-ZzPwam-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:39:31 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:39:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:39:31 INFO - Running setup.py (path:/tmp/pip-ly9Sia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:39:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:39:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:39:31 INFO - Running setup.py (path:/tmp/pip-9WfhwG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:39:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:39:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:39:31 INFO - Running setup.py (path:/tmp/pip-Vbq8FE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:39:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:39:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:39:31 INFO - Running setup.py (path:/tmp/pip-llDBF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:39:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:39:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:39:31 INFO - Running setup.py (path:/tmp/pip-cMI0ya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:39:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:39:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:39:31 INFO - Running setup.py (path:/tmp/pip-67X_TZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:39:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:39:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:39:31 INFO - Running setup.py (path:/tmp/pip-AydBlS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:39:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:39:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:39:31 INFO - Running setup.py (path:/tmp/pip-wDz8bo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:39:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:39:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:39:31 INFO - Running setup.py (path:/tmp/pip-OM7EtY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:39:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:39:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:39:31 INFO - Running setup.py (path:/tmp/pip-1qt44A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:39:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:39:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:39:32 INFO - Running setup.py (path:/tmp/pip-0g6WRO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:39:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:39:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:39:32 INFO - Running setup.py (path:/tmp/pip-QJKwuP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:39:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:39:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:39:32 INFO - Running setup.py (path:/tmp/pip-pbLims-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:39:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:39:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:39:32 INFO - Running setup.py (path:/tmp/pip-0RW5JM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:39:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:39:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:39:32 INFO - Running setup.py (path:/tmp/pip-Ed0AAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:39:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:39:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:39:32 INFO - Running setup.py (path:/tmp/pip-Adkgsj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:39:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:39:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:39:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:39:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:39:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:39:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:39:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:39:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:34 INFO - Downloading blessings-1.6.tar.gz 05:39:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:39:34 INFO - Installing collected packages: blessings 05:39:34 INFO - Running setup.py install for blessings 05:39:34 INFO - Successfully installed blessings 05:39:34 INFO - Cleaning up... 05:39:34 INFO - Return code: 0 05:39:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:39:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:39:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:39:34 INFO - Reading from file tmpfile_stdout 05:39:34 INFO - Current package versions: 05:39:34 INFO - argparse == 1.2.1 05:39:34 INFO - blessings == 1.6 05:39:34 INFO - blobuploader == 1.2.4 05:39:34 INFO - docopt == 0.6.1 05:39:34 INFO - functools32 == 3.2.3-2 05:39:34 INFO - jsonschema == 2.5.1 05:39:34 INFO - manifestparser == 1.1 05:39:34 INFO - mozInstall == 1.12 05:39:34 INFO - mozcrash == 1.0 05:39:34 INFO - mozdebug == 0.1 05:39:34 INFO - mozdevice == 0.49 05:39:34 INFO - mozfile == 1.2 05:39:34 INFO - mozhttpd == 0.7 05:39:34 INFO - mozinfo == 0.9 05:39:34 INFO - mozleak == 0.1 05:39:34 INFO - mozlog == 3.4 05:39:34 INFO - moznetwork == 0.27 05:39:34 INFO - mozprocess == 0.25 05:39:34 INFO - mozprofile == 0.28 05:39:34 INFO - mozrunner == 6.13 05:39:34 INFO - mozscreenshot == 0.1 05:39:34 INFO - mozsystemmonitor == 0.3 05:39:34 INFO - moztest == 0.8 05:39:34 INFO - mozversion == 1.4 05:39:34 INFO - psutil == 3.1.1 05:39:34 INFO - requests == 1.2.3 05:39:34 INFO - wsgiref == 0.1.2 05:39:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:39: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')]} 05:39:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39: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')]} 05:39:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:34 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 0x14921f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x172fb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172d290>, '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 0x172db90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x172e040>, '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': 'ea65d483da93c827905c2090000001f5-1490013442.628433-1600166000', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:39:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:39:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:39:34 INFO - Using env: {'DISPLAY': ':0', 05:39:34 INFO - 'HOME': '/home/cltbld', 05:39:34 INFO - 'LANG': 'en_US.UTF-8', 05:39:34 INFO - 'LANGUAGE': 'en_US:en', 05:39:34 INFO - 'LOGNAME': 'cltbld', 05:39:34 INFO - 'MAIL': '/var/mail/cltbld', 05:39:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:34 INFO - 'MOZ_NO_REMOTE': '1', 05:39:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:34 INFO - 'NO_EM_RESTART': '1', 05:39:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:34 INFO - 'PWD': '/builds/slave/test', 05:39:34 INFO - 'SHELL': '/bin/bash', 05:39:34 INFO - 'SHLVL': '1', 05:39:34 INFO - 'TERM': 'linux', 05:39:34 INFO - 'TMOUT': '86400', 05:39:34 INFO - 'USER': 'cltbld', 05:39:34 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1490013442.628433-1600166000', 05:39:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:34 INFO - '_': '/tools/buildbot/bin/python'} 05:39:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:39:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:39:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:39:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:39:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:39:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:39:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:39:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:39:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:39:35 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:39:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:39:35 INFO - Cleaning up... 05:39:35 INFO - Return code: 0 05:39:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:39:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:35 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 0x14921f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x172fb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172d290>, '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 0x172db90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x172e040>, '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': 'ea65d483da93c827905c2090000001f5-1490013442.628433-1600166000', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:39:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:39:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:39:35 INFO - Using env: {'DISPLAY': ':0', 05:39:35 INFO - 'HOME': '/home/cltbld', 05:39:35 INFO - 'LANG': 'en_US.UTF-8', 05:39:35 INFO - 'LANGUAGE': 'en_US:en', 05:39:35 INFO - 'LOGNAME': 'cltbld', 05:39:35 INFO - 'MAIL': '/var/mail/cltbld', 05:39:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:35 INFO - 'MOZ_NO_REMOTE': '1', 05:39:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:35 INFO - 'NO_EM_RESTART': '1', 05:39:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:35 INFO - 'PWD': '/builds/slave/test', 05:39:35 INFO - 'SHELL': '/bin/bash', 05:39:35 INFO - 'SHLVL': '1', 05:39:35 INFO - 'TERM': 'linux', 05:39:35 INFO - 'TMOUT': '86400', 05:39:35 INFO - 'USER': 'cltbld', 05:39:35 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1490013442.628433-1600166000', 05:39:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:35 INFO - '_': '/tools/buildbot/bin/python'} 05:39:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:39:35 INFO - Cleaning up... 05:39:35 INFO - Return code: 0 05:39:35 INFO - Running post-action listener: _resource_record_post_action 05:39:35 INFO - Running post-action listener: _start_resource_monitoring 05:39:35 INFO - Starting resource monitoring. 05:39:35 INFO - [mozharness: 2017-03-20 12:39:35.447777Z] Finished create-virtualenv step (success) 05:39:35 INFO - [mozharness: 2017-03-20 12:39:35.448291Z] Running install step. 05:39:35 INFO - Running pre-action listener: _resource_record_pre_action 05:39:35 INFO - Running main action method: install 05:39:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:39:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:39:35 INFO - Reading from file tmpfile_stdout 05:39:35 INFO - Detecting whether we're running mozinstall >=1.0... 05:39:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:39:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:39:35 INFO - Reading from file tmpfile_stdout 05:39:35 INFO - Output received: 05:39:35 INFO - Usage: mozinstall [options] installer 05:39:35 INFO - Options: 05:39:35 INFO - -h, --help show this help message and exit 05:39:35 INFO - -d DEST, --destination=DEST 05:39:35 INFO - Directory to install application into. [default: 05:39:35 INFO - "/builds/slave/test"] 05:39:35 INFO - --app=APP Application being installed. [default: firefox] 05:39:35 INFO - mkdir: /builds/slave/test/build/application 05:39:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:39:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:39:51 INFO - Reading from file tmpfile_stdout 05:39:51 INFO - Output received: 05:39:51 INFO - /builds/slave/test/build/application/firefox/firefox 05:39:51 INFO - Running post-action listener: _resource_record_post_action 05:39:51 INFO - [mozharness: 2017-03-20 12:39:51.214850Z] Finished install step (success) 05:39:51 INFO - [mozharness: 2017-03-20 12:39:51.214996Z] Running run-tests step. 05:39:51 INFO - Running pre-action listener: _resource_record_pre_action 05:39:51 INFO - Running main action method: run_tests 05:39:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:39:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:39:51 INFO - Python 2.7.3 05:39:51 INFO - Return code: 0 05:39:51 INFO - grabbing minidump binary from tooltool 05:39:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:51 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 0x172d290>, '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 0x172db90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x172e040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:39:51 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:39:51 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:39:51 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:39:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:39:51 INFO - Return code: 0 05:39:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:39:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:39:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:39:51 INFO - ENV: RUST_BACKTRACE is now 1 05:39:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:39:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:39:51 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IsQj73FnScWDCarTb52gqQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-084', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:39:51 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IsQj73FnScWDCarTb52gqQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-084 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:39:51 INFO - Using env: {'DISPLAY': ':0', 05:39:51 INFO - 'HOME': '/home/cltbld', 05:39:51 INFO - 'LANG': 'en_US.UTF-8', 05:39:51 INFO - 'LANGUAGE': 'en_US:en', 05:39:51 INFO - 'LOGNAME': 'cltbld', 05:39:51 INFO - 'MAIL': '/var/mail/cltbld', 05:39:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:39:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:39:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:51 INFO - 'MOZ_NO_REMOTE': '1', 05:39:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:39:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:51 INFO - 'NO_EM_RESTART': '1', 05:39:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:51 INFO - 'PWD': '/builds/slave/test', 05:39:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:39:51 INFO - 'RUST_BACKTRACE': '1', 05:39:51 INFO - 'SHELL': '/bin/bash', 05:39:51 INFO - 'SHLVL': '1', 05:39:51 INFO - 'TERM': 'linux', 05:39:51 INFO - 'TMOUT': '86400', 05:39:51 INFO - 'USER': 'cltbld', 05:39:51 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1490013442.628433-1600166000', 05:39:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:51 INFO - '_': '/tools/buildbot/bin/python'} 05:39:51 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IsQj73FnScWDCarTb52gqQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-084', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:39:51 INFO - mozversion application_buildid: 20170320121057 05:39:51 INFO - mozversion application_changeset: 8d967436d696d1f8e3fb33cf7e3d32a72457ffa6 05:39:51 INFO - mozversion application_display_name: Nightly 05:39:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:39:51 INFO - mozversion application_name: Firefox 05:39:51 INFO - mozversion application_remotingname: firefox 05:39:51 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:39:51 INFO - mozversion application_vendor: Mozilla 05:39:51 INFO - mozversion application_version: 55.0a1 05:39:51 INFO - mozversion platform_buildid: 20170320121057 05:39:51 INFO - mozversion platform_changeset: 8d967436d696d1f8e3fb33cf7e3d32a72457ffa6 05:39:51 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:39:51 INFO - mozversion platform_version: 55.0a1 05:39:51 INFO - using testdate: 1490013591 05:39:51 INFO - actual date: 1490013591 05:39:51 INFO - starting webserver on 'localhost:46133' 05:39:51 INFO - SUITE-START | Running 2 tests 05:39:51 INFO - TEST-START | dromaeo_css 05:39:51 INFO - operating with platform_type : linux_ 05:39:51 INFO - Initialising browser for dromaeo_css test... 05:39:51 INFO - TEST-INFO | started process 12537 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyUoG1M/profile http://localhost:46133/getInfo.html) 05:39:56 INFO - PID 12537 | __metrics Screen width/height:1600/1200 05:39:56 INFO - PID 12537 | colorDepth:24 05:39:56 INFO - PID 12537 | Browser inner width/height: 1024/697 05:39:56 INFO - PID 12537 | __metrics 05:39:57 ERROR - PID 12537 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 05:39:58 INFO - TEST-INFO | 12537: exit 0 05:39:58 INFO - Browser initialized. 05:39:58 INFO - Running cycle 1/1 for dromaeo_css test... 05:39:58 INFO - TEST-INFO | started process 12669 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyUoG1M/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:40:10 INFO - PID 12669 | RSS: Main: 157802496 05:40:10 INFO - PID 12669 | 05:43:14 INFO - PID 12669 | Cycle 1(1): loaded http://localhost:46133/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46133/tests/dromaeo/cssquery-ext.html) 05:43:17 INFO - PID 12669 | RSS: Main: 166907904 05:43:17 INFO - PID 12669 | 05:44:59 INFO - PID 12669 | ************************* 05:44:59 INFO - PID 12669 | A coding exception was thrown and uncaught in a Task. 05:44:59 INFO - PID 12669 | 05:44:59 ERROR - PID 12669 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:44:59 INFO - PID 12669 | Full stack: 05:44:59 INFO - PID 12669 | ************************* 05:46:20 INFO - PID 12669 | Cycle 1(1): loaded http://localhost:46133/tests/dromaeo/cssquery-ext.html (next: http://localhost:46133/tests/dromaeo/cssquery-jquery.html) 05:46:20 INFO - PID 12669 | RSS: Main: 160276480 05:46:20 INFO - PID 12669 | 05:49:23 INFO - PID 12669 | Cycle 1(1): loaded http://localhost:46133/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46133/tests/dromaeo/cssquery-mootools.html) 05:49:23 INFO - PID 12669 | RSS: Main: 168583168 05:49:23 INFO - PID 12669 | 05:52:25 INFO - PID 12669 | Cycle 1(1): loaded http://localhost:46133/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46133/tests/dromaeo/cssquery-prototype.html) 05:52:26 INFO - PID 12669 | RSS: Main: 161382400 05:52:26 INFO - PID 12669 | 05:55:29 INFO - PID 12669 | Cycle 1(1): loaded http://localhost:46133/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46133/tests/dromaeo/cssquery-yui.html) 05:55:29 INFO - PID 12669 | RSS: Main: 169816064 05:55:29 INFO - PID 12669 | 05:58:32 INFO - PID 12669 | Cycle 1(1): loaded http://localhost:46133/tests/dromaeo/cssquery-yui.html (next: http://localhost:46133/tests/dromaeo/cssquery-dojo.html) 05:58:33 INFO - PID 12669 | RSS: Main: 161488896 05:58:33 INFO - PID 12669 | 05:58:33 INFO - PID 12669 | __start_tp_report 05:58:33 INFO - PID 12669 | _x_x_mozilla_page_load 05:58:33 INFO - PID 12669 | _x_x_mozilla_page_load_details 05:58:33 INFO - PID 12669 | |i|pagename|runs| 05:58:33 INFO - PID 12669 | |0;dojo.html;2666.6000099985;2667.4265033017896;2672.091488893776;2705.905293314733;2706.323419145214;4947.554720075197;4955.355803745512;4985.252212168168;5025.296458495814;5064.949350506494;5024.447310795809;5054.1660625996665;5102.719350435734;5103.106956282645;5123.333966584348;4320.287152619814;4563.383943167663;4577.977110114453;4589.839355622554;4750.786214620333;4658.860234192963;4670.836520721776;4676.649251306166;4696.225122854725;4705.741184234866;4488.775561221926;4543.886402839922;4600.332951721982;4605.148047611203;4636.188666983265;4584.40402747644;4604.953950460486;4615.746133962631;4638.884027899296;4664.370310008139;4544.204764166291;4574.428196475441;4588.105319462706;4599.31010348447;4612.723236605781;4935.925961110586;4936.975315123437;4979.15354389751;4998.500149985009;5009.574186194178;5406.972965135188;5414.7021913795115;5431.185322201662;5440.102383106782;5484.287042684466;5432.972835135839;5433.864153396157;5443.183522471661;5458.072127738294;5478.671279723229;5001.374828146481;5055.721935293521;5083.847484575469;5096.974515127475;5106.872328191825;5389.865253368619;5551.250581171571;5596.664200148004;5619.775208991677;5635.1828984796975;5291.867703307448;5299.205119232146;5300.231466437345;5308.522232998971;5333.919991200135;5276.868078297996;5362.785488580491;5400.83797486076;5407.026735187704;5427.023135835509;5362;5364.034473794676;5367.651102678314;5374.48942350476;5374.892502149935;5415.783368665209;5418.647787893774;5419.132938729785;5430.321209848769;5450.31871016123;4523.660725445605;4609.985803123308;4624.560666736655;4628.976855115703;4630.83792067276;3970.841166353371;3988.900277493086;4013.1171142348635;4028.879133625996;4033.798310084484;4627.467841198238;4657.86026419208;4674.929876051862;4682.484926658065;4683.7892294846815;5435.347758269033;5457.672539647634;5475.151351540438;5523.502884740312;5534.916976245359;4685.929711054337;4686.226772582554;4691.81232750693;4695.460022097503;4742.549457801503;4801.135795556834;4841.733704646208;4872.8781780455065;4877.146499362598;4931.038447502774;5041.6470847040355;5063;5085.847424577269;5104.03023425548;5113.590912727047;5339.546138578265;5362.088444964287;5365.38298095724;5365.704886231295;5368.812091576776;4956.8760780980765;4984.22744474607;4992.126377883783;4993.925091123709;4999.900021995155;5364.731763411735;5369.382521009978;5375.516203541543;5376.139817629317;5385.46145385474;5377.381601115765;5435.266239057677;5443.782248710166;5447.53695935834;5452.672839629635;5217.973910130577;5271.472852714851;5272.920906186334;5274.314339135888;5274.868128296824;5237.0835103857435;5266.447023062523;5309.123994541012;5312.070387682217;5335.33308336458;5195.584353251656;5215.791368345223;5220.530152286313;5245.89508209826;5247.842564723064;5316.255724198692;5340.706261155674;5367.946320536901;5376.354837419534;5385.030694475032;5142.871428214325;5171.379434467888;5176.042432150064;5177.767000485062;5229.346331708536 05:58:33 INFO - PID 12669 | |1;ext.html;697.8953157026447;721.2030706069794;789.3054112381104;796.1083586383255;845.9577021148941;31727.682723172762;32532;32631.83684081579;32831.17922051947;32979;28727.856360718168;29205;29307.560386594218;29350.55974160384;29418.11745647634;6067.514598832105;6220.222472190976;6227.159333489966;8951.910480895172;9167.724968250963;9072.909270907305;9099.999000109983;9146.54267286633;9201.263898888106;9214.262858971266;9143.634254629807;9209.631614735403;9226.169644731974;9266.814663706722;9277.443353398783;9177.678781242657;9208.53957302139;9220.631174753002;9238.676646317414;9255.444673319622;9031.367804253705;9202.861957070649;9204.21764150048;9213;9248;33898.66101339005;34049.82975085109;34097.488537671954;34145.487817682755;34448.48327275093;3327.717144042759;3338.966610333914;3342.8662853486076;3381.323735252959;3387.932241355159;23714;23743.406414839596;23824.64263036056;24474.632880506808;24518.387040323956;3320.5849268841393;3424.5890493140732;3494.1490657900736;3533.752637315389;3536.9646303536892;151219.4634160977;151721;152426;153025;153064.234678827;31613.5257971126;32305.676943230737;36709;41170.38244426336;41216;38023;38735.22529549449;39004.80497597494;41131.7943410281;41588.58411415847;13189.208647481182;13210.141340812816;13313.667158320926;13316.46734130624;13349.866501335056;10669;10675.199360048027;10679.412632305142;10690.41202733857;10699.25105242641;12878.742425151444;12899.35503224835;12939.611811645478;12941.223526588436;13079.149855259378;5157.638965272395;5200.531952124327;5260.316158899319;5288;5443.673379597237;794.4954953604503;811.3711873298241;844.1895780051096;847.3644766425181;859.6647307550061;22305;22441.438964025703;22991.885040575024;23074.423139421313;23088.769112308997;880.1858281089966;885.2254277507182;902.8465160922527;904.8416527107861;909.5861383070687;12222.755544889053;12253;12264.38678066093;12274.324912129918;12300.507979680713;204312;204771;204922;205430;205870;40984.79507602443;41062;41395.37906931398;41420.792896035324;41485.1702965939;1163.7730642524627;1188.292965685433;1199.8260252263547;1212.5513559982862;1319.33373646308;20750.273740419012;21492.462688432915;22562.774372256725;22702.65946010778;22715.88642056845;29849;29880.551791722708;29892.85053574718;29898;29948.101556953327;190156;191704;191838;193243;193635;21980.670289945345;22346.21788237404;25104.62343064819;27307.180784576496;27338;29653.25866853346;30747.692523075377;30880.382392351577;30885.691143088283;30987.535186971763;25679.743202567734;26105.608415873397;27099.360332646433;28203.2949176264;28580.14259572216;28721;29850.402991939605;31292.530612041293;31538.842305788323;32047.679523205403;32111.678883211804;32489.512657309686;32805.195714235946;32896;32975;32667.836660817495;33846.66153338435;34124;34187;35566.11084722903;26145.73854261433;27993;28177.859110704314;28523.714762852935;28541.28646783847 05:58:33 INFO - PID 12669 | |2;jquery.html;401.1555675303488;405.8640355480913;407.9938800917987;420.3841372389449;421.09464651000343;12447.439865206064;15124.6975060499;17102;17627.55931101723;17767.111644417793;16441.67116657666;16513.83486165141;16654.75017874733;16661;16868.240929158186;5338.866528336804;5488;5536.667799932017;5600.4959553640165;5610.214569960209;5287.629865909388;5537.086380747192;5539.584531160159;5556.666600004012;6380.744770209186;6643.734250629969;6682.93317066828;6692.9665351673175;6709.865802683968;6729.899051514231;6540.9861471471995;6660.200775906874;6661.566998145129;6752.594844309308;6754.9662251688915;6339.4611458025665;6543.345665433466;6547.443467305285;6564.474842012628;6580.078788969548;21328.573428531497;21468.248611298528;21649.35051948444;21793;21830.345089647337;2176.869387836735;2228;2289.6565515172692;2297.6438652008965;2323.0939933425975;13055.543055992996;13864.237466939314;13939.233342166177;14052.227127507984;14565.708685826225;1696.6097797506643;1698.320671731305;1735.3145507524584;1743.790745110582;1751.343246282644;81922;82012.58993705054;82196.58901705453;83247;84826.57586712026;15896.523104306889;16162.272697728395;16384;16399.91800040992;16633.586145177553;25148.24555263345;27416.588751168747;27448.313792154957;27680.169594912186;27744.583831242548;8222.588870556448;8263.462874913112;8371.83256334882;8532.402731808714;8597;6772.72909083641;7006.4745144114395;7032.261612530713;7215.170255420589;7227.566346019255;8524.616392262238;8932.660100984904;8939.955300223588;9073.863892041625;9132.269418446509;3405.3529829332347;3447.67247111524;3722.8521239220763;3738.6074462181077;3756.549214094326;803.4697099914029;806.9651741293533;846.0946786937917;852.654674856684;858.0347109501811;17558.82441175572;17571.472855814347;17896.299851514086;18686.159122839505;19119;836.3434703757521;841.4446465332974;846.1031306814673;850.1625898489982;862.4049405909902;9426.717198484057;10076.647317343857;10183.083522483012;10214.387136771817;10328.380297182193;433104;444244;465511;473192;475821;90710.09289907017;91017.54491227501;91341.54329228445;92670;94407.52796236113;1111.8832522585174;1163.5520324674892;1178.834963105183;1196.9401529923643;1197.0902114393125;16651.50045498637;16956.09282127277;17455.738163927297;17625.91187044108;17752.28990840352;32248;37453.81273093617;37680.623193767715;43918.34122488101;45326;49507.8312078503;49683.751581241864;51472;51629.741851290506;61114.38885611265;10642;10738.355698658106;10986.670399888017;11193.888061119285;11385.943070284595;12330.568430105262;12492.937535312265;12890.67773305675;12990.675233119247;13278.336083195994;10988.285761425483;11365.659030229106;11458.770824583295;11481.94259028733;11559.884401155881;10011.199104071511;10427.530761115617;10802.567897284021;10829.783404331713;10875.129989600971;8244.711435099744;10130.79738405213;11189.552417903193;11302.943485282522;11493.367864767519;10663.360198388122;10964.177686673691;10975.725606859893;11061.170412219277;11091.778164436828;10979;11041.39272340029;11151.72120696989;11178.385188814367;11178.441077946232 05:58:33 INFO - PID 12669 | |3;mootools.html;1412.6538997945504;1438.0005895902345;1448.1455940994817;1457.6355911022245;1513.4248985385555;8890.511021893793;9113.270938324935;9303.76740581485;9358.672446464376;9362.578683959222;9286.396384235037;9491.810163796737;9511.239100871931;9517.095875891797;9520.523973801299;2005.5988802239574;2038.2560365466572;2041.836653067751;2048.897555122245;2051.4358551398336;1977.9703304450445;2010.3064442767295;2030.9695354569694;2031.6444622191132;2034.888081155536;1960.980390196094;1996;1997.530580313625;2001.0795034284247;2001.2895422125155;1964.9607007859906;1974.7531558555181;1978.4855937456293;1984.2459865251255;1987.5726718755536;1918.24229429376;1934.5067007913033;1984.4542750743517;1990.3232900813794;2000.369883486697;9332.72001839946;9441.575129119206;9471.621135154586;9480.762980925532;9518.428894266297;4421.53573874745;4532.864014079583;4577.793999270041;4584.885377865547;4601.263797792337;2526.4441822798954;2661.7072122066556;2680.946381072368;2704.607831864388;2723.5233834079154;947.8104379124203;973.5083782689767;1002.7643503776607;1019.1846522781744;1025.2259544044273;11405.600803971904;11664.416779161093;11985.880141198564;12010;12592.685182870502;3652.7077833773233;3720.4977328060363;3833.15670552478;3852.4413959975645;3853.9807300963876;9719.61121555144;9728.902710972941;9730.735004449376;9733.513324333897;9745.756356091013;4474.172278128557;4492.820287188476;4503.549645035536;4515.029268707178;4519.864404067883;4107.691923105719;4161.83352665896;4225.366195070703;4229.344451610005;4245.1934132514725;3090.443720130353;3222.4199644063824;3248.902532924016;3277.4428347181038;3279.9344013119603;817.995910020458;823.9752807415667;828.718235799831;839.3033781960958;839.6053854688287;812.4678335690132;818.6602559937678;824.6247957179469;828.2545708861952;831.4720152702956;5282.392524859691;5720.256366672389;5775.133729940459;5861;5865.912011319833;883.6156272021691;891.9152680495342;901.193431878465;908.04655112132;911.4212475078241;3333.1667083229195;3406.3017081498233;3415.282790613949;3449.896503104911;3490.598581163148;11003.394813285346;11519.19365644397;11636.301821890713;11646.359450230319;11666.241694289844;11945.522179112912;12046.698832529082;12068.818967715491;12095.939520302341;12102.394880255952;7885.763427097197;8047.356211503065;8088.919110808934;8096.230858068474;8348.874766878502;4907.877303067452;5391.568674506108;5416.21464887597;5533.6403133797785;5594.552435805207;9740.269479788902;9915.206783457163;9943.850842237227;9963.551640176354;10094.394336339843;9949.452780097165;10079.949600252245;10098.848517272394;10374.948125259325;10377.325473844176;7281.745138920112;7384.113906331275;7409.147947986051;7424.96287518559;7447.702091916262;8118.2693557580105;8222.958885205535;8226.629801659059;8227.547484888388;8228.25945664893;7280.817979550554;7545.584992825227;7555.093388793161;7657.310842024244;7900.249476299742;7584;7608.695652174072;7648.426368022309;7653.311201991847;7784.92215077842;6290.874182516232;6490.253620833664;6492.675366231575;6497.057926600522;6498.220213574401;4831.275308703723;4863.708177509361;4902.2156454967035;4953.2074868020945;5123.28274041627;4880.194767863263;4905.4358748742925;4962.975185124195;4991.3511243538105;5015.799368025238 05:58:33 INFO - PID 12669 | |4;prototype.html;356.92682999984976;359.8075029859025;364.6572222111215;366.172450262407;366.40825067515954;5417;5426.647267927582;5429.59278054146;5444.3194600674915;5486.61593688442;5304.522592966632;5307.840764777063;5316;5321.534335782024;5331.2003199520095;4182.351735481006;4409.184300904343;4420.226460369438;4446.7554284514335;4450.5104438511735;4420.160169567788;4429.357743127244;4429.579189976947;4438;4444.466664000308;4407.9779601101945;4430.712003719764;4433.667474939376;4447.777611119447;4451.666125040619;4230.646193218156;4396.450443694538;4417.779111044435;4428.756418396987;4430.911381772363;4073.9185216295805;4084.673226141931;4090.2637525245445;4103.199876024177;4117.938230926538;5174.560162386202;5182.559482443997;5185.766640501187;5193.584513238932;5196.662216955886;5058.2412638104215;5154.38147422308;5166.914947860953;5169.56058735008;5169.689818610896;5642.887142257173;5646.661200327993;5655.236543066716;5703.173039909231;5706.315242170925;4525.140223357585;4528.977355113237;4534.79593418297;4545.09098180362;4563.9087218255445;5769.5191067840815;5929.436703513203;5977.5815692901515;5997.490213331872;6020.789272375446;4689.882752931136;4690.788914498788;4695.906081878344;4704.482506924235;4716.9292460613115;4773.188557945157;4792.2332426811545;4802.711837289774;4803.303520989507;4805.183118869801;4977.8257760978195;5111.415461207038;5144.61415393847;5163.870903227375;5172.456892026358;5633.774649014075;5648.350439699405;5648.774049037993;5649.576281778883;5669.206311116447;1589.4754730938762;1646.588352911772;1674.2884274183666;1679.7816283883262;1682.932682692703;1219.7072702551502;1224.9203801752858;1255.3911352993791;1264.563725514696;1269.1940617707821;4887.242477416006;4926.45808961014;4927.260910863399;4932.778024988884;4952.5542701157065;5812.779316343615;5835.649861008353;5848.561357898175;5849.1226316052935;5856.238688970492;4680.765961701969;4914.483979182134;4934.037862616755;4954.603631709455;4981.526754958273;3086.213015680987;3108.6011294917375;3112.0352690665513;3112.4397608430245;3136.8274744888795;5394.811181608625;5420.24116623673;5427.891442171134;5428.4028756836715;5432.076546987022;5736.225609542658;5876.588638795243;5891.351951285355;5937.753071854959;5986.640801551921;5360.8659783504945;5377.516023557899;5408.729563521808;5412.161115027098;5416.187571864252;5595.664260144405;5857.794977175949;5860.179574859438;5878.147668587945;5902.61632993854;5761.740721667451;5824.330202026821;5834.299884013945;5841.094630332305;5859.121131830259;5492.533134683436;5496.148097044965;5502.642328248651;5512.3660779010925;5529.3964750221985;4551.158035763395;4696.506866778939;4737.715737055788;4748.667593268438;4760.952390476051;5930.280218736518;5933.495652869382;5935.821925342247;5940.46535811779;5948.940510594839;5700.201971723879;5702.1161719931815;5722.570807189394;5734.684592347461;5789.334226563999;5357.678539287655;5648.378678345461;5690.118031705092;5693.430656934273;5714.371419143974;5595.860103497445;5596.188552659923;5612.915806262991;5624.184493248538;5651.2935883014625;5429.402765695691;5631.183478395692;5706.258186435903;5749.8275051748515;5764.221830053057;5552.750126244248;5584.497395234286;5606.411326810789;5607.775688972395;5610.438956104357 05:58:33 INFO - PID 12669 | |5;yui.html;710.8436144048308;732.7655150351886;755.0147058089199;764.0831002796643;782.7847341980953;12527.749445011093;13030.348482575857;13065.150765200255;13071.346432678376;13072.542461013867;12632.873671263307;12707.110502264844;12708.110432269721;12746.171498852591;13457.663558411045;814.775936617432;820.2535692519823;838.1995194589183;839.8698201778703;847.3390755210945;845.720912099009;847.2713466418875;847.4237518487427;847.9067302596709;853.4282031039219;877.1666916429417;890.8040231149137;891.0198781340538;895.7312806158159;897.407710910799;882.6028287270753;889.9599518021672;891.2780647675404;891.7859713668738;892.7321803459001;649.6459429610874;654.3979538824293;655.878662447444;657.086649557116;661.6361001449184;12662.620121396372;12952;13768.105073170213;13851.861481385258;13949;13453.932730336384;13988.090774099754;14014.92992535041;14226.535211549111;14312.856871431257;10485.737856553571;10657.307275027099;10693;11021.173411994132;11125.777484450347;3174.746020318369;3196.9360612787846;3216.8713251469912;3218.7907785993834;3348.866045358183;66834.66582667055;67178;67896.3210367895;68496.6575167126;68702;10332.586696532055;10394.896051039545;10499.790004199873;10553.419561924014;10677.786444271227;21328.36014919555;21373.67939480909;21405.357839264536;21419.57160856774;21559.56880862405;6567.540272180901;6640.136782218281;6803.2856550062525;6918.757843475454;6947.89578156328;3493.161641206143;3510.227749895019;3512;3529.5588051493564;3601.819909004539;2840.7585355245037;2886.4515742008953;2911.985440072786;2919.3285544324926;2919.430711011375;455.0444067458311;458.57581736893906;460.06377022759193;463.1639889998585;469.6501106675549;630.4483576870239;633.4647223096476;655.8884989551788;661.7981515637777;662.7945336945465;8970.461772293684;9037.367384283169;9053.728388148365;9198.224105247076;9369.578368973413;637.8501052252717;660.3660485933461;673.2997682410238;679.4700133895569;685.7908337956972;4075.409065685459;4246.808893599796;4277.786110694453;4305.182015417061;4328.177646247203;59297.40702592919;60520.69739651361;62635.6868215656;64071;64082;53643.73178134162;54571.18143227855;54670.17994730082;55250;57438.13842792278;48077;48924.26613600799;49080;49456.50543494519;49758.50241497611;8157.6329065193395;8365.414420990472;8388.496690198608;8410.411271210956;8607.913920860712;34346.48480272848;34926.82536587301;34988.47517287192;35299.11752206215;35420;39835.2032959345;40155.19689606133;40467.595324046386;40872.18255634811;41693;10472.895271047191;10504.78990420172;10597;10633.734156646145;11040.447977601249;11548.133889958455;11634.127440441831;11646.475908583965;11732.354720490455;12294;10239.539220735234;10404.68785936423;10668.1998850085;10671.839922401015;10990.725231869268;10966.780664386828;11276.605318813803;11415.942920285346;11429.257098288585;11781.175317727677;9540.570674319533;9778.462184579916;9957.9767002489;9974.451405172786;10363.274570780275;8478.2424926529;8679.783005424915;8712;8761.38670293099;9366.344355895295;7538.547687138789;8232.259096681088;8264.917350826414;8342.749717508485;8855.64577416922 05:58:33 INFO - PID 12669 | __end_tp_report 05:58:33 INFO - PID 12669 | __start_cc_report 05:58:33 INFO - PID 12669 | _x_x_mozilla_cycle_collect,389 05:58:33 INFO - PID 12669 | __end_cc_report 05:58:33 INFO - PID 12669 | __startTimestamp1490014713223__endTimestamp 05:58:33 INFO - PID 12669 | 05:58:33 INFO - PID 12669 | ------- Summary: start ------- 05:58:33 INFO - PID 12669 | Number of tests: 6 05:58:33 INFO - PID 12669 | 05:58:33 INFO - PID 12669 | [#0] dojo.html Cycles:165 Average:4988.50 Median:5106.87 stddev:549.40 (10.8%) stddev-sans-first:520.02 05:58:33 INFO - PID 12669 | Values: 2666.6 2667.4 2672.1 2705.9 2706.3 4947.6 4955.4 4985.3 5025.3 5064.9 5024.4 5054.2 5102.7 5103.1 5123.3 4320.3 4563.4 4578.0 4589.8 4750.8 4658.9 4670.8 4676.6 4696.2 4705.7 4488.8 4543.9 4600.3 4605.1 4636.2 4584.4 4605.0 4615.7 4638.9 4664.4 4544.2 4574.4 4588.1 4599.3 4612.7 4935.9 4937.0 4979.2 4998.5 5009.6 5407.0 5414.7 5431.2 5440.1 5484.3 5433.0 5433.9 5443.2 5458.1 5478.7 5001.4 5055.7 5083.8 5097.0 5106.9 5389.9 5551.3 5596.7 5619.8 5635.2 5291.9 5299.2 5300.2 5308.5 5333.9 5276.9 5362.8 5400.8 5407.0 5427.0 5362.0 5364.0 5367.7 5374.5 5374.9 5415.8 5418.6 5419.1 5430.3 5450.3 4523.7 4610.0 4624.6 4629.0 4630.8 3970.8 3988.9 4013.1 4028.9 4033.8 4627.5 4657.9 4674.9 4682.5 4683.8 5435.3 5457.7 5475.2 5523.5 5534.9 4685.9 4686.2 4691.8 4695.5 4742.5 4801.1 4841.7 4872.9 4877.1 4931.0 5041.6 5063.0 5085.8 5104.0 5113.6 5339.5 5362.1 5365.4 5365.7 5368.8 4956.9 4984.2 4992.1 4993.9 4999.9 5364.7 5369.4 5375.5 5376.1 5385.5 5377.4 5435.3 5443.8 5447.5 5452.7 5218.0 5271.5 5272.9 5274.3 5274.9 5237.1 5266.4 5309.1 5312.1 5335.3 5195.6 5215.8 5220.5 5245.9 5247.8 5316.3 5340.7 5367.9 5376.4 5385.0 5142.9 5171.4 5176.0 5177.8 5229.3 05:58:33 INFO - PID 12669 | 05:58:33 INFO - PID 12669 | [#1] ext.html Cycles:180 Average:32739.75 Median:31887.68 stddev:47584.55 (149.2%) stddev-sans-first:47657.21 05:58:33 INFO - PID 12669 | Values: 697.9 721.2 789.3 796.1 846.0 31727.7 32532.0 32631.8 32831.2 32979.0 28727.9 29205.0 29307.6 29350.6 29418.1 6067.5 6220.2 6227.2 8951.9 9167.7 9072.9 9100.0 9146.5 9201.3 9214.3 9143.6 9209.6 9226.2 9266.8 9277.4 9177.7 9208.5 9220.6 9238.7 9255.4 9031.4 9202.9 9204.2 9213.0 9248.0 33898.7 34049.8 34097.5 34145.5 34448.5 3327.7 3339.0 3342.9 3381.3 3387.9 23714.0 23743.4 23824.6 24474.6 24518.4 3320.6 3424.6 3494.1 3533.8 3537.0 151219.5 151721.0 152426.0 153025.0 153064.2 31613.5 32305.7 36709.0 41170.4 41216.0 38023.0 38735.2 39004.8 41131.8 41588.6 13189.2 13210.1 13313.7 13316.5 13349.9 10669.0 10675.2 10679.4 10690.4 10699.3 12878.7 12899.4 12939.6 12941.2 13079.1 5157.6 5200.5 5260.3 5288.0 5443.7 794.5 811.4 844.2 847.4 859.7 22305.0 22441.4 22991.9 23074.4 23088.8 880.2 885.2 902.8 904.8 909.6 12222.8 12253.0 12264.4 12274.3 12300.5 204312.0 204771.0 204922.0 205430.0 205870.0 40984.8 41062.0 41395.4 41420.8 41485.2 1163.8 1188.3 1199.8 1212.6 1319.3 20750.3 21492.5 22562.8 22702.7 22715.9 29849.0 29880.6 29892.9 29898.0 29948.1 190156.0 191704.0 191838.0 193243.0 193635.0 21980.7 22346.2 25104.6 27307.2 27338.0 29653.3 30747.7 30880.4 30885.7 30987.5 25679.7 26105.6 27099.4 28203.3 28580.1 28721.0 29850.4 31292.5 31538.8 32047.7 32111.7 32489.5 32805.2 32896.0 32975.0 32667.8 33846.7 34124.0 34187.0 35566.1 26145.7 27993.0 28177.9 28523.7 28541.3 05:58:33 INFO - PID 12669 | 05:58:33 INFO - PID 12669 | [#2] jquery.html Cycles:180 Average:28523.62 Median:27564.24 stddev:75676.81 (274.5%) stddev-sans-first:75859.64 05:58:33 INFO - PID 12669 | Values: 401.2 405.9 408.0 420.4 421.1 12447.4 15124.7 17102.0 17627.6 17767.1 16441.7 16513.8 16654.8 16661.0 16868.2 5338.9 5488.0 5536.7 5600.5 5610.2 5287.6 5537.1 5539.6 5556.7 6380.7 6643.7 6682.9 6693.0 6709.9 6729.9 6541.0 6660.2 6661.6 6752.6 6755.0 6339.5 6543.3 6547.4 6564.5 6580.1 21328.6 21468.2 21649.4 21793.0 21830.3 2176.9 2228.0 2289.7 2297.6 2323.1 13055.5 13864.2 13939.2 14052.2 14565.7 1696.6 1698.3 1735.3 1743.8 1751.3 81922.0 82012.6 82196.6 83247.0 84826.6 15896.5 16162.3 16384.0 16399.9 16633.6 25148.2 27416.6 27448.3 27680.2 27744.6 8222.6 8263.5 8371.8 8532.4 8597.0 6772.7 7006.5 7032.3 7215.2 7227.6 8524.6 8932.7 8940.0 9073.9 9132.3 3405.4 3447.7 3722.9 3738.6 3756.5 803.5 807.0 846.1 852.7 858.0 17558.8 17571.5 17896.3 18686.2 19119.0 836.3 841.4 846.1 850.2 862.4 9426.7 10076.6 10183.1 10214.4 10328.4 433104.0 444244.0 465511.0 473192.0 475821.0 90710.1 91017.5 91341.5 92670.0 94407.5 1111.9 1163.6 1178.8 1196.9 1197.1 16651.5 16956.1 17455.7 17625.9 17752.3 32248.0 37453.8 37680.6 43918.3 45326.0 49507.8 49683.8 51472.0 51629.7 61114.4 10642.0 10738.4 10986.7 11193.9 11385.9 12330.6 12492.9 12890.7 12990.7 13278.3 10988.3 11365.7 11458.8 11481.9 11559.9 10011.2 10427.5 10802.6 10829.8 10875.1 8244.7 10130.8 11189.6 11302.9 11493.4 10663.4 10964.2 10975.7 11061.2 11091.8 10979.0 11041.4 11151.7 11178.4 11178.4 05:58:33 INFO - PID 12669 | 05:58:33 INFO - PID 12669 | [#3] mootools.html Cycles:180 Average:5585.86 Median:4891.21 stddev:3506.47 (71.7%) stddev-sans-first:3502.29 05:58:33 INFO - PID 12669 | Values: 1412.7 1438.0 1448.1 1457.6 1513.4 8890.5 9113.3 9303.8 9358.7 9362.6 9286.4 9491.8 9511.2 9517.1 9520.5 2005.6 2038.3 2041.8 2048.9 2051.4 1978.0 2010.3 2031.0 2031.6 2034.9 1961.0 1996.0 1997.5 2001.1 2001.3 1965.0 1974.8 1978.5 1984.2 1987.6 1918.2 1934.5 1984.5 1990.3 2000.4 9332.7 9441.6 9471.6 9480.8 9518.4 4421.5 4532.9 4577.8 4584.9 4601.3 2526.4 2661.7 2680.9 2704.6 2723.5 947.8 973.5 1002.8 1019.2 1025.2 11405.6 11664.4 11985.9 12010.0 12592.7 3652.7 3720.5 3833.2 3852.4 3854.0 9719.6 9728.9 9730.7 9733.5 9745.8 4474.2 4492.8 4503.5 4515.0 4519.9 4107.7 4161.8 4225.4 4229.3 4245.2 3090.4 3222.4 3248.9 3277.4 3279.9 818.0 824.0 828.7 839.3 839.6 812.5 818.7 824.6 828.3 831.5 5282.4 5720.3 5775.1 5861.0 5865.9 883.6 891.9 901.2 908.0 911.4 3333.2 3406.3 3415.3 3449.9 3490.6 11003.4 11519.2 11636.3 11646.4 11666.2 11945.5 12046.7 12068.8 12095.9 12102.4 7885.8 8047.4 8088.9 8096.2 8348.9 4907.9 5391.6 5416.2 5533.6 5594.6 9740.3 9915.2 9943.9 9963.6 10094.4 9949.5 10079.9 10098.8 10374.9 10377.3 7281.7 7384.1 7409.1 7425.0 7447.7 8118.3 8223.0 8226.6 8227.5 8228.3 7280.8 7545.6 7555.1 7657.3 7900.2 7584.0 7608.7 7648.4 7653.3 7784.9 6290.9 6490.3 6492.7 6497.1 6498.2 4831.3 4863.7 4902.2 4953.2 5123.3 4880.2 4905.4 4963.0 4991.4 5015.8 05:58:33 INFO - PID 12669 | 05:58:33 INFO - PID 12669 | [#4] prototype.html Cycles:180 Average:4832.12 Median:5306.18 stddev:1301.39 (24.5%) stddev-sans-first:1260.95 05:58:33 INFO - PID 12669 | Values: 356.9 359.8 364.7 366.2 366.4 5417.0 5426.6 5429.6 5444.3 5486.6 5304.5 5307.8 5316.0 5321.5 5331.2 4182.4 4409.2 4420.2 4446.8 4450.5 4420.2 4429.4 4429.6 4438.0 4444.5 4408.0 4430.7 4433.7 4447.8 4451.7 4230.6 4396.5 4417.8 4428.8 4430.9 4073.9 4084.7 4090.3 4103.2 4117.9 5174.6 5182.6 5185.8 5193.6 5196.7 5058.2 5154.4 5166.9 5169.6 5169.7 5642.9 5646.7 5655.2 5703.2 5706.3 4525.1 4529.0 4534.8 4545.1 4563.9 5769.5 5929.4 5977.6 5997.5 6020.8 4689.9 4690.8 4695.9 4704.5 4716.9 4773.2 4792.2 4802.7 4803.3 4805.2 4977.8 5111.4 5144.6 5163.9 5172.5 5633.8 5648.4 5648.8 5649.6 5669.2 1589.5 1646.6 1674.3 1679.8 1682.9 1219.7 1224.9 1255.4 1264.6 1269.2 4887.2 4926.5 4927.3 4932.8 4952.6 5812.8 5835.6 5848.6 5849.1 5856.2 4680.8 4914.5 4934.0 4954.6 4981.5 3086.2 3108.6 3112.0 3112.4 3136.8 5394.8 5420.2 5427.9 5428.4 5432.1 5736.2 5876.6 5891.4 5937.8 5986.6 5360.9 5377.5 5408.7 5412.2 5416.2 5595.7 5857.8 5860.2 5878.1 5902.6 5761.7 5824.3 5834.3 5841.1 5859.1 5492.5 5496.1 5502.6 5512.4 5529.4 4551.2 4696.5 4737.7 4748.7 4761.0 5930.3 5933.5 5935.8 5940.5 5948.9 5700.2 5702.1 5722.6 5734.7 5789.3 5357.7 5648.4 5690.1 5693.4 5714.4 5595.9 5596.2 5612.9 5624.2 5651.3 5429.4 5631.2 5706.3 5749.8 5764.2 5552.8 5584.5 5606.4 5607.8 5610.4 05:58:33 INFO - PID 12669 | 05:58:33 INFO - PID 12669 | [#5] yui.html Cycles:180 Average:14495.98 Median:24273.33 stddev:18005.33 (74.2%) stddev-sans-first:18026.09 05:58:33 INFO - PID 12669 | Values: 710.8 732.8 755.0 764.1 782.8 12527.7 13030.3 13065.2 13071.3 13072.5 12632.9 12707.1 12708.1 12746.2 13457.7 814.8 820.3 838.2 839.9 847.3 845.7 847.3 847.4 847.9 853.4 877.2 890.8 891.0 895.7 897.4 882.6 890.0 891.3 891.8 892.7 649.6 654.4 655.9 657.1 661.6 12662.6 12952.0 13768.1 13851.9 13949.0 13453.9 13988.1 14014.9 14226.5 14312.9 10485.7 10657.3 10693.0 11021.2 11125.8 3174.7 3196.9 3216.9 3218.8 3348.9 66834.7 67178.0 67896.3 68496.7 68702.0 10332.6 10394.9 10499.8 10553.4 10677.8 21328.4 21373.7 21405.4 21419.6 21559.6 6567.5 6640.1 6803.3 6918.8 6947.9 3493.2 3510.2 3512.0 3529.6 3601.8 2840.8 2886.5 2912.0 2919.3 2919.4 455.0 458.6 460.1 463.2 469.7 630.4 633.5 655.9 661.8 662.8 8970.5 9037.4 9053.7 9198.2 9369.6 637.9 660.4 673.3 679.5 685.8 4075.4 4246.8 4277.8 4305.2 4328.2 59297.4 60520.7 62635.7 64071.0 64082.0 53643.7 54571.2 54670.2 55250.0 57438.1 48077.0 48924.3 49080.0 49456.5 49758.5 8157.6 8365.4 8388.5 8410.4 8607.9 34346.5 34926.8 34988.5 35299.1 35420.0 39835.2 40155.2 40467.6 40872.2 41693.0 10472.9 10504.8 10597.0 10633.7 11040.4 11548.1 11634.1 11646.5 11732.4 12294.0 10239.5 10404.7 10668.2 10671.8 10990.7 10966.8 11276.6 11415.9 11429.3 11781.2 9540.6 9778.5 9958.0 9974.5 10363.3 8478.2 8679.8 8712.0 8761.4 9366.3 7538.5 8232.3 8264.9 8342.7 8855.6 05:58:33 INFO - PID 12669 | -------- Summary: end -------- 05:58:33 INFO - PID 12669 | 05:58:34 INFO - TEST-INFO | 12669: exit 0 05:58:34 INFO - TEST-OK | dromaeo_css | took 1122632ms 05:58:34 INFO - TEST-START | kraken 05:58:34 INFO - operating with platform_type : linux_ 05:58:34 INFO - Initialising browser for kraken test... 05:58:34 INFO - TEST-INFO | started process 13048 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpR1pW2L/profile http://localhost:46133/getInfo.html) 05:58:38 INFO - PID 13048 | __metrics Screen width/height:1600/1200 05:58:38 INFO - PID 13048 | colorDepth:24 05:58:38 INFO - PID 13048 | Browser inner width/height: 1024/697 05:58:38 INFO - PID 13048 | __metrics 05:58:39 ERROR - PID 13048 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 05:58:40 INFO - TEST-INFO | 13048: exit 0 05:58:40 INFO - Browser initialized. 05:58:40 INFO - Running cycle 1/1 for kraken test... 05:58:40 INFO - TEST-INFO | started process 13180 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpR1pW2L/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:58:52 INFO - PID 13180 | RSS: Main: 155537408 05:58:52 INFO - PID 13180 | 05:58:55 INFO - PID 13180 | Cycle 1(1): loaded http://localhost:46133/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46133/tests/kraken/driver.html?testName=audio-beat-detection) 05:58:56 INFO - PID 13180 | RSS: Main: 161243136 05:58:56 INFO - PID 13180 | 05:58:59 INFO - PID 13180 | Cycle 1(1): loaded http://localhost:46133/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46133/tests/kraken/driver.html?testName=audio-dft) 05:58:59 INFO - PID 13180 | RSS: Main: 160538624 05:58:59 INFO - PID 13180 | 05:59:02 INFO - PID 13180 | Cycle 1(1): loaded http://localhost:46133/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46133/tests/kraken/driver.html?testName=audio-fft) 05:59:03 INFO - PID 13180 | RSS: Main: 157384704 05:59:03 INFO - PID 13180 | 05:59:05 INFO - PID 13180 | Cycle 1(1): loaded http://localhost:46133/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46133/tests/kraken/driver.html?testName=audio-oscillator) 05:59:06 INFO - PID 13180 | RSS: Main: 157745152 05:59:06 INFO - PID 13180 | 05:59:08 INFO - PID 13180 | Cycle 1(1): loaded http://localhost:46133/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46133/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:59:09 INFO - PID 13180 | RSS: Main: 158171136 05:59:09 INFO - PID 13180 | 05:59:12 INFO - PID 13180 | Cycle 1(1): loaded http://localhost:46133/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46133/tests/kraken/driver.html?testName=imaging-darkroom) 05:59:12 INFO - PID 13180 | RSS: Main: 163778560 05:59:12 INFO - PID 13180 | 05:59:16 INFO - PID 13180 | Cycle 1(1): loaded http://localhost:46133/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46133/tests/kraken/driver.html?testName=imaging-desaturate) 05:59:17 INFO - PID 13180 | RSS: Main: 160980992 05:59:17 INFO - PID 13180 | 05:59:20 INFO - PID 13180 | Cycle 1(1): loaded http://localhost:46133/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46133/tests/kraken/driver.html?testName=json-parse-financial) 05:59:20 INFO - PID 13180 | RSS: Main: 162033664 05:59:20 INFO - PID 13180 | 05:59:22 INFO - PID 13180 | Cycle 1(1): loaded http://localhost:46133/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46133/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:59:23 INFO - PID 13180 | RSS: Main: 162398208 05:59:23 INFO - PID 13180 | 05:59:25 INFO - PID 13180 | Cycle 1(1): loaded http://localhost:46133/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46133/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:59:25 INFO - PID 13180 | RSS: Main: 162308096 05:59:25 INFO - PID 13180 | 05:59:28 INFO - PID 13180 | Cycle 1(1): loaded http://localhost:46133/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46133/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:59:28 INFO - PID 13180 | RSS: Main: 163274752 05:59:28 INFO - PID 13180 | 05:59:31 INFO - PID 13180 | Cycle 1(1): loaded http://localhost:46133/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46133/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:59:32 INFO - PID 13180 | RSS: Main: 163352576 05:59:32 INFO - PID 13180 | 05:59:35 INFO - PID 13180 | Cycle 1(1): loaded http://localhost:46133/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46133/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:59:36 INFO - PID 13180 | RSS: Main: 163180544 05:59:36 INFO - PID 13180 | 05:59:37 INFO - PID 13180 | Cycle 1(1): loaded http://localhost:46133/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46133/tests/kraken/driver.html?testName=ai-astar) 05:59:38 INFO - PID 13180 | RSS: Main: 164737024 05:59:38 INFO - PID 13180 | 05:59:38 INFO - PID 13180 | __start_tp_report 05:59:38 INFO - PID 13180 | _x_x_mozilla_page_load 05:59:38 INFO - PID 13180 | _x_x_mozilla_page_load_details 05:59:38 INFO - PID 13180 | |i|pagename|runs| 05:59:38 INFO - PID 13180 | |0;ai-astar;114;119;119;120;121;119;120;121;122;120 05:59:38 INFO - PID 13180 | |1;audio-beat-detection;151;127;128;172;128;128;126;126;150;124 05:59:38 INFO - PID 13180 | |2;audio-dft;165;164;167;171;167;169;164;167;164;166 05:59:38 INFO - PID 13180 | |3;audio-fft;78;76;76;106;75;76;75;76;97;76 05:59:38 INFO - PID 13180 | |4;audio-oscillator;84;84;111;85;85;85;109;87;86;107 05:59:38 INFO - PID 13180 | |5;imaging-gaussian-blur;114;114;114;114;114;118;115;114;114;114 05:59:38 INFO - PID 13180 | |6;imaging-darkroom;151;150;152;150;152;149;151;151;149;150 05:59:38 INFO - PID 13180 | |7;imaging-desaturate;95;96;95;94;95;95;95;96;94;100 05:59:38 INFO - PID 13180 | |8;json-parse-financial;72;72;74;71;72;73;75;71;73;71 05:59:38 INFO - PID 13180 | |9;json-stringify-tinderbox;56;55;56;55;57;59;56;56;56;55 05:59:38 INFO - PID 13180 | |10;stanford-crypto-aes;82;98;84;81;91;83;82;91;82;82 05:59:38 INFO - PID 13180 | |11;stanford-crypto-ccm;140;150;135;134;134;140;140;135;182;139 05:59:38 INFO - PID 13180 | |12;stanford-crypto-pbkdf2;195;196;197;198;194;193;196;202;188;197 05:59:38 INFO - PID 13180 | |13;stanford-crypto-sha256-iterative;74;73;74;71;73;72;72;70;73;74 05:59:38 INFO - PID 13180 | __end_tp_report 05:59:38 INFO - PID 13180 | __start_cc_report 05:59:38 INFO - PID 13180 | _x_x_mozilla_cycle_collect,877 05:59:38 INFO - PID 13180 | __end_cc_report 05:59:38 INFO - PID 13180 | __startTimestamp1490014778210__endTimestamp 05:59:38 INFO - PID 13180 | 05:59:38 INFO - PID 13180 | ------- Summary: start ------- 05:59:38 INFO - PID 13180 | Number of tests: 14 05:59:38 INFO - PID 13180 | 05:59:38 INFO - PID 13180 | [#0] ai-astar Cycles:10 Average:119.50 Median:120.00 stddev:2.17 (1.8%) stddev-sans-first:1.05 05:59:38 INFO - PID 13180 | Values: 114.0 119.0 119.0 120.0 121.0 119.0 120.0 121.0 122.0 120.0 05:59:38 INFO - PID 13180 | 05:59:38 INFO - PID 13180 | [#1] audio-beat-detection Cycles:10 Average:136.00 Median:128.00 stddev:16.10 (12.6%) stddev-sans-first:16.14 05:59:38 INFO - PID 13180 | Values: 151.0 127.0 128.0 172.0 128.0 128.0 126.0 126.0 150.0 124.0 05:59:38 INFO - PID 13180 | 05:59:38 INFO - PID 13180 | [#2] audio-dft Cycles:10 Average:166.40 Median:167.00 stddev:2.32 (1.4%) stddev-sans-first:2.40 05:59:38 INFO - PID 13180 | Values: 165.0 164.0 167.0 171.0 167.0 169.0 164.0 167.0 164.0 166.0 05:59:38 INFO - PID 13180 | 05:59:38 INFO - PID 13180 | [#3] audio-fft Cycles:10 Average:81.10 Median:76.00 stddev:10.99 (14.5%) stddev-sans-first:11.60 05:59:38 INFO - PID 13180 | Values: 78.0 76.0 76.0 106.0 75.0 76.0 75.0 76.0 97.0 76.0 05:59:38 INFO - PID 13180 | 05:59:38 INFO - PID 13180 | [#4] audio-oscillator Cycles:10 Average:92.30 Median:85.00 stddev:11.60 (13.6%) stddev-sans-first:11.90 05:59:38 INFO - PID 13180 | Values: 84.0 84.0 111.0 85.0 85.0 85.0 109.0 87.0 86.0 107.0 05:59:38 INFO - PID 13180 | 05:59:38 INFO - PID 13180 | [#5] imaging-gaussian-blur Cycles:10 Average:114.50 Median:114.00 stddev:1.27 (1.1%) stddev-sans-first:1.33 05:59:38 INFO - PID 13180 | Values: 114.0 114.0 114.0 114.0 114.0 118.0 115.0 114.0 114.0 114.0 05:59:38 INFO - PID 13180 | 05:59:38 INFO - PID 13180 | [#6] imaging-darkroom Cycles:10 Average:150.50 Median:151.00 stddev:1.08 (0.7%) stddev-sans-first:1.13 05:59:38 INFO - PID 13180 | Values: 151.0 150.0 152.0 150.0 152.0 149.0 151.0 151.0 149.0 150.0 05:59:38 INFO - PID 13180 | 05:59:38 INFO - PID 13180 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.00 stddev:1.72 (1.8%) stddev-sans-first:1.81 05:59:38 INFO - PID 13180 | Values: 95.0 96.0 95.0 94.0 95.0 95.0 95.0 96.0 94.0 100.0 05:59:38 INFO - PID 13180 | 05:59:38 INFO - PID 13180 | [#8] json-parse-financial Cycles:10 Average:72.40 Median:72.50 stddev:1.35 (1.9%) stddev-sans-first:1.42 05:59:38 INFO - PID 13180 | Values: 72.0 72.0 74.0 71.0 72.0 73.0 75.0 71.0 73.0 71.0 05:59:38 INFO - PID 13180 | 05:59:38 INFO - PID 13180 | [#9] json-stringify-tinderbox Cycles:10 Average:56.10 Median:56.00 stddev:1.20 (2.1%) stddev-sans-first:1.27 05:59:38 INFO - PID 13180 | Values: 56.0 55.0 56.0 55.0 57.0 59.0 56.0 56.0 56.0 55.0 05:59:38 INFO - PID 13180 | 05:59:38 INFO - PID 13180 | [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:83.50 stddev:5.72 (6.8%) stddev-sans-first:5.92 05:59:38 INFO - PID 13180 | Values: 82.0 98.0 84.0 81.0 91.0 83.0 82.0 91.0 82.0 82.0 05:59:38 INFO - PID 13180 | 05:59:38 INFO - PID 13180 | [#11] stanford-crypto-ccm Cycles:10 Average:142.90 Median:140.00 stddev:14.54 (10.4%) stddev-sans-first:15.38 05:59:38 INFO - PID 13180 | Values: 140.0 150.0 135.0 134.0 134.0 140.0 140.0 135.0 182.0 139.0 05:59:38 INFO - PID 13180 | 05:59:38 INFO - PID 13180 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:195.60 Median:196.50 stddev:3.63 (1.8%) stddev-sans-first:3.84 05:59:38 INFO - PID 13180 | Values: 195.0 196.0 197.0 198.0 194.0 193.0 196.0 202.0 188.0 197.0 05:59:38 INFO - PID 13180 | 05:59:38 INFO - PID 13180 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.60 Median:73.00 stddev:1.35 (1.8%) stddev-sans-first:1.33 05:59:38 INFO - PID 13180 | Values: 74.0 73.0 74.0 71.0 73.0 72.0 72.0 70.0 73.0 74.0 05:59:38 INFO - PID 13180 | -------- Summary: end -------- 05:59:38 INFO - PID 13180 | 05:59:39 INFO - TEST-INFO | 13180: exit 0 05:59:39 INFO - TEST-OK | kraken | took 65292ms 05:59:39 INFO - SUITE-END | took 1187s 05:59:39 INFO - Completed test suite (00:19:48) 05:59:39 INFO - javascript benchmark 05:59:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6666.654727283743, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2666.6000099985, 2667.4265033017896, 2672.091488893776, 2705.905293314733, 2706.323419145214, 4947.554720075197, 4955.355803745512, 4985.252212168168, 5025.296458495814, 5064.949350506494, 5024.447310795809, 5054.1660625996665, 5102.719350435734, 5103.106956282645, 5123.333966584348, 4320.287152619814, 4563.383943167663, 4577.977110114453, 4589.839355622554, 4750.786214620333, 4658.860234192963, 4670.836520721776, 4676.649251306166, 4696.225122854725, 4705.741184234866, 4488.775561221926, 4543.886402839922, 4600.332951721982, 4605.148047611203, 4636.188666983265, 4584.40402747644, 4604.953950460486, 4615.746133962631, 4638.884027899296, 4664.370310008139, 4544.204764166291, 4574.428196475441, 4588.105319462706, 4599.31010348447, 4612.723236605781, 4935.925961110586, 4936.975315123437, 4979.15354389751, 4998.500149985009, 5009.574186194178, 5406.972965135188, 5414.7021913795115, 5431.185322201662, 5440.102383106782, 5484.287042684466, 5432.972835135839, 5433.864153396157, 5443.183522471661, 5458.072127738294, 5478.671279723229, 5001.374828146481, 5055.721935293521, 5083.847484575469, 5096.974515127475, 5106.872328191825, 5389.865253368619, 5551.250581171571, 5596.664200148004, 5619.775208991677, 5635.1828984796975, 5291.867703307448, 5299.205119232146, 5300.231466437345, 5308.522232998971, 5333.919991200135, 5276.868078297996, 5362.785488580491, 5400.83797486076, 5407.026735187704, 5427.023135835509, 5362.0, 5364.034473794676, 5367.651102678314, 5374.48942350476, 5374.892502149935, 5415.783368665209, 5418.647787893774, 5419.132938729785, 5430.321209848769, 5450.31871016123, 4523.660725445605, 4609.985803123308, 4624.560666736655, 4628.976855115703, 4630.83792067276, 3970.841166353371, 3988.900277493086, 4013.1171142348635, 4028.879133625996, 4033.798310084484, 4627.467841198238, 4657.86026419208, 4674.929876051862, 4682.484926658065, 4683.7892294846815, 5435.347758269033, 5457.672539647634, 5475.151351540438, 5523.502884740312, 5534.916976245359, 4685.929711054337, 4686.226772582554, 4691.81232750693, 4695.460022097503, 4742.549457801503, 4801.135795556834, 4841.733704646208, 4872.8781780455065, 4877.146499362598, 4931.038447502774, 5041.6470847040355, 5063.0, 5085.847424577269, 5104.03023425548, 5113.590912727047, 5339.546138578265, 5362.088444964287, 5365.38298095724, 5365.704886231295, 5368.812091576776, 4956.8760780980765, 4984.22744474607, 4992.126377883783, 4993.925091123709, 4999.900021995155, 5364.731763411735, 5369.382521009978, 5375.516203541543, 5376.139817629317, 5385.46145385474, 5377.381601115765, 5435.266239057677, 5443.782248710166, 5447.53695935834, 5452.672839629635, 5217.973910130577, 5271.472852714851, 5272.920906186334, 5274.314339135888, 5274.868128296824, 5237.0835103857435, 5266.447023062523, 5309.123994541012, 5312.070387682217, 5335.33308336458, 5195.584353251656, 5215.791368345223, 5220.530152286313, 5245.89508209826, 5247.842564723064, 5316.255724198692, 5340.706261155674, 5367.946320536901, 5376.354837419534, 5385.030694475032, 5142.871428214325, 5171.379434467888, 5176.042432150064, 5177.767000485062, 5229.346331708536], "value": 4950.772524111106, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [697.8953157026447, 721.2030706069794, 789.3054112381104, 796.1083586383255, 845.9577021148941, 31727.682723172762, 32532.0, 32631.83684081579, 32831.17922051947, 32979.0, 28727.856360718168, 29205.0, 29307.560386594218, 29350.55974160384, 29418.11745647634, 6067.514598832105, 6220.222472190976, 6227.159333489966, 8951.910480895172, 9167.724968250963, 9072.909270907305, 9099.999000109983, 9146.54267286633, 9201.263898888106, 9214.262858971266, 9143.634254629807, 9209.631614735403, 9226.169644731974, 9266.814663706722, 9277.443353398783, 9177.678781242657, 9208.53957302139, 9220.631174753002, 9238.676646317414, 9255.444673319622, 9031.367804253705, 9202.861957070649, 9204.21764150048, 9213.0, 9248.0, 33898.66101339005, 34049.82975085109, 34097.488537671954, 34145.487817682755, 34448.48327275093, 3327.717144042759, 3338.966610333914, 3342.8662853486076, 3381.323735252959, 3387.932241355159, 23714.0, 23743.406414839596, 23824.64263036056, 24474.632880506808, 24518.387040323956, 3320.5849268841393, 3424.5890493140732, 3494.1490657900736, 3533.752637315389, 3536.9646303536892, 151219.4634160977, 151721.0, 152426.0, 153025.0, 153064.234678827, 31613.5257971126, 32305.676943230737, 36709.0, 41170.38244426336, 41216.0, 38023.0, 38735.22529549449, 39004.80497597494, 41131.7943410281, 41588.58411415847, 13189.208647481182, 13210.141340812816, 13313.667158320926, 13316.46734130624, 13349.866501335056, 10669.0, 10675.199360048027, 10679.412632305142, 10690.41202733857, 10699.25105242641, 12878.742425151444, 12899.35503224835, 12939.611811645478, 12941.223526588436, 13079.149855259378, 5157.638965272395, 5200.531952124327, 5260.316158899319, 5288.0, 5443.673379597237, 794.4954953604503, 811.3711873298241, 844.1895780051096, 847.3644766425181, 859.6647307550061, 22305.0, 22441.438964025703, 22991.885040575024, 23074.423139421313, 23088.769112308997, 880.1858281089966, 885.2254277507182, 902.8465160922527, 904.8416527107861, 909.5861383070687, 12222.755544889053, 12253.0, 12264.38678066093, 12274.324912129918, 12300.507979680713, 204312.0, 204771.0, 204922.0, 205430.0, 205870.0, 40984.79507602443, 41062.0, 41395.37906931398, 41420.792896035324, 41485.1702965939, 1163.7730642524627, 1188.292965685433, 1199.8260252263547, 1212.5513559982862, 1319.33373646308, 20750.273740419012, 21492.462688432915, 22562.774372256725, 22702.65946010778, 22715.88642056845, 29849.0, 29880.551791722708, 29892.85053574718, 29898.0, 29948.101556953327, 190156.0, 191704.0, 191838.0, 193243.0, 193635.0, 21980.670289945345, 22346.21788237404, 25104.62343064819, 27307.180784576496, 27338.0, 29653.25866853346, 30747.692523075377, 30880.382392351577, 30885.691143088283, 30987.535186971763, 25679.743202567734, 26105.608415873397, 27099.360332646433, 28203.2949176264, 28580.14259572216, 28721.0, 29850.402991939605, 31292.530612041293, 31538.842305788323, 32047.679523205403, 32111.678883211804, 32489.512657309686, 32805.195714235946, 32896.0, 32975.0, 32667.836660817495, 33846.66153338435, 34124.0, 34187.0, 35566.11084722903, 26145.73854261433, 27993.0, 28177.859110704314, 28523.714762852935, 28541.28646783847], "value": 15273.591911658601, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [401.1555675303488, 405.8640355480913, 407.9938800917987, 420.3841372389449, 421.09464651000343, 12447.439865206064, 15124.6975060499, 17102.0, 17627.55931101723, 17767.111644417793, 16441.67116657666, 16513.83486165141, 16654.75017874733, 16661.0, 16868.240929158186, 5338.866528336804, 5488.0, 5536.667799932017, 5600.4959553640165, 5610.214569960209, 5287.629865909388, 5537.086380747192, 5539.584531160159, 5556.666600004012, 6380.744770209186, 6643.734250629969, 6682.93317066828, 6692.9665351673175, 6709.865802683968, 6729.899051514231, 6540.9861471471995, 6660.200775906874, 6661.566998145129, 6752.594844309308, 6754.9662251688915, 6339.4611458025665, 6543.345665433466, 6547.443467305285, 6564.474842012628, 6580.078788969548, 21328.573428531497, 21468.248611298528, 21649.35051948444, 21793.0, 21830.345089647337, 2176.869387836735, 2228.0, 2289.6565515172692, 2297.6438652008965, 2323.0939933425975, 13055.543055992996, 13864.237466939314, 13939.233342166177, 14052.227127507984, 14565.708685826225, 1696.6097797506643, 1698.320671731305, 1735.3145507524584, 1743.790745110582, 1751.343246282644, 81922.0, 82012.58993705054, 82196.58901705453, 83247.0, 84826.57586712026, 15896.523104306889, 16162.272697728395, 16384.0, 16399.91800040992, 16633.586145177553, 25148.24555263345, 27416.588751168747, 27448.313792154957, 27680.169594912186, 27744.583831242548, 8222.588870556448, 8263.462874913112, 8371.83256334882, 8532.402731808714, 8597.0, 6772.72909083641, 7006.4745144114395, 7032.261612530713, 7215.170255420589, 7227.566346019255, 8524.616392262238, 8932.660100984904, 8939.955300223588, 9073.863892041625, 9132.269418446509, 3405.3529829332347, 3447.67247111524, 3722.8521239220763, 3738.6074462181077, 3756.549214094326, 803.4697099914029, 806.9651741293533, 846.0946786937917, 852.654674856684, 858.0347109501811, 17558.82441175572, 17571.472855814347, 17896.299851514086, 18686.159122839505, 19119.0, 836.3434703757521, 841.4446465332974, 846.1031306814673, 850.1625898489982, 862.4049405909902, 9426.717198484057, 10076.647317343857, 10183.083522483012, 10214.387136771817, 10328.380297182193, 433104.0, 444244.0, 465511.0, 473192.0, 475821.0, 90710.09289907017, 91017.54491227501, 91341.54329228445, 92670.0, 94407.52796236113, 1111.8832522585174, 1163.5520324674892, 1178.834963105183, 1196.9401529923643, 1197.0902114393125, 16651.50045498637, 16956.09282127277, 17455.738163927297, 17625.91187044108, 17752.28990840352, 32248.0, 37453.81273093617, 37680.623193767715, 43918.34122488101, 45326.0, 49507.8312078503, 49683.751581241864, 51472.0, 51629.741851290506, 61114.38885611265, 10642.0, 10738.355698658106, 10986.670399888017, 11193.888061119285, 11385.943070284595, 12330.568430105262, 12492.937535312265, 12890.67773305675, 12990.675233119247, 13278.336083195994, 10988.285761425483, 11365.659030229106, 11458.770824583295, 11481.94259028733, 11559.884401155881, 10011.199104071511, 10427.530761115617, 10802.567897284021, 10829.783404331713, 10875.129989600971, 8244.711435099744, 10130.79738405213, 11189.552417903193, 11302.943485282522, 11493.367864767519, 10663.360198388122, 10964.177686673691, 10975.725606859893, 11061.170412219277, 11091.778164436828, 10979.0, 11041.39272340029, 11151.72120696989, 11178.385188814367, 11178.441077946232], "value": 9750.151299943102, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1412.6538997945504, 1438.0005895902345, 1448.1455940994817, 1457.6355911022245, 1513.4248985385555, 8890.511021893793, 9113.270938324935, 9303.76740581485, 9358.672446464376, 9362.578683959222, 9286.396384235037, 9491.810163796737, 9511.239100871931, 9517.095875891797, 9520.523973801299, 2005.5988802239574, 2038.2560365466572, 2041.836653067751, 2048.897555122245, 2051.4358551398336, 1977.9703304450445, 2010.3064442767295, 2030.9695354569694, 2031.6444622191132, 2034.888081155536, 1960.980390196094, 1996.0, 1997.530580313625, 2001.0795034284247, 2001.2895422125155, 1964.9607007859906, 1974.7531558555181, 1978.4855937456293, 1984.2459865251255, 1987.5726718755536, 1918.24229429376, 1934.5067007913033, 1984.4542750743517, 1990.3232900813794, 2000.369883486697, 9332.72001839946, 9441.575129119206, 9471.621135154586, 9480.762980925532, 9518.428894266297, 4421.53573874745, 4532.864014079583, 4577.793999270041, 4584.885377865547, 4601.263797792337, 2526.4441822798954, 2661.7072122066556, 2680.946381072368, 2704.607831864388, 2723.5233834079154, 947.8104379124203, 973.5083782689767, 1002.7643503776607, 1019.1846522781744, 1025.2259544044273, 11405.600803971904, 11664.416779161093, 11985.880141198564, 12010.0, 12592.685182870502, 3652.7077833773233, 3720.4977328060363, 3833.15670552478, 3852.4413959975645, 3853.9807300963876, 9719.61121555144, 9728.902710972941, 9730.735004449376, 9733.513324333897, 9745.756356091013, 4474.172278128557, 4492.820287188476, 4503.549645035536, 4515.029268707178, 4519.864404067883, 4107.691923105719, 4161.83352665896, 4225.366195070703, 4229.344451610005, 4245.1934132514725, 3090.443720130353, 3222.4199644063824, 3248.902532924016, 3277.4428347181038, 3279.9344013119603, 817.995910020458, 823.9752807415667, 828.718235799831, 839.3033781960958, 839.6053854688287, 812.4678335690132, 818.6602559937678, 824.6247957179469, 828.2545708861952, 831.4720152702956, 5282.392524859691, 5720.256366672389, 5775.133729940459, 5861.0, 5865.912011319833, 883.6156272021691, 891.9152680495342, 901.193431878465, 908.04655112132, 911.4212475078241, 3333.1667083229195, 3406.3017081498233, 3415.282790613949, 3449.896503104911, 3490.598581163148, 11003.394813285346, 11519.19365644397, 11636.301821890713, 11646.359450230319, 11666.241694289844, 11945.522179112912, 12046.698832529082, 12068.818967715491, 12095.939520302341, 12102.394880255952, 7885.763427097197, 8047.356211503065, 8088.919110808934, 8096.230858068474, 8348.874766878502, 4907.877303067452, 5391.568674506108, 5416.21464887597, 5533.6403133797785, 5594.552435805207, 9740.269479788902, 9915.206783457163, 9943.850842237227, 9963.551640176354, 10094.394336339843, 9949.452780097165, 10079.949600252245, 10098.848517272394, 10374.948125259325, 10377.325473844176, 7281.745138920112, 7384.113906331275, 7409.147947986051, 7424.96287518559, 7447.702091916262, 8118.2693557580105, 8222.958885205535, 8226.629801659059, 8227.547484888388, 8228.25945664893, 7280.817979550554, 7545.584992825227, 7555.093388793161, 7657.310842024244, 7900.249476299742, 7584.0, 7608.695652174072, 7648.426368022309, 7653.311201991847, 7784.92215077842, 6290.874182516232, 6490.253620833664, 6492.675366231575, 6497.057926600522, 6498.220213574401, 4831.275308703723, 4863.708177509361, 4902.2156454967035, 4953.2074868020945, 5123.28274041627, 4880.194767863263, 4905.4358748742925, 4962.975185124195, 4991.3511243538105, 5015.799368025238], "value": 4270.092934750491, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.92682999984976, 359.8075029859025, 364.6572222111215, 366.172450262407, 366.40825067515954, 5417.0, 5426.647267927582, 5429.59278054146, 5444.3194600674915, 5486.61593688442, 5304.522592966632, 5307.840764777063, 5316.0, 5321.534335782024, 5331.2003199520095, 4182.351735481006, 4409.184300904343, 4420.226460369438, 4446.7554284514335, 4450.5104438511735, 4420.160169567788, 4429.357743127244, 4429.579189976947, 4438.0, 4444.466664000308, 4407.9779601101945, 4430.712003719764, 4433.667474939376, 4447.777611119447, 4451.666125040619, 4230.646193218156, 4396.450443694538, 4417.779111044435, 4428.756418396987, 4430.911381772363, 4073.9185216295805, 4084.673226141931, 4090.2637525245445, 4103.199876024177, 4117.938230926538, 5174.560162386202, 5182.559482443997, 5185.766640501187, 5193.584513238932, 5196.662216955886, 5058.2412638104215, 5154.38147422308, 5166.914947860953, 5169.56058735008, 5169.689818610896, 5642.887142257173, 5646.661200327993, 5655.236543066716, 5703.173039909231, 5706.315242170925, 4525.140223357585, 4528.977355113237, 4534.79593418297, 4545.09098180362, 4563.9087218255445, 5769.5191067840815, 5929.436703513203, 5977.5815692901515, 5997.490213331872, 6020.789272375446, 4689.882752931136, 4690.788914498788, 4695.906081878344, 4704.482506924235, 4716.9292460613115, 4773.188557945157, 4792.2332426811545, 4802.711837289774, 4803.303520989507, 4805.183118869801, 4977.8257760978195, 5111.415461207038, 5144.61415393847, 5163.870903227375, 5172.456892026358, 5633.774649014075, 5648.350439699405, 5648.774049037993, 5649.576281778883, 5669.206311116447, 1589.4754730938762, 1646.588352911772, 1674.2884274183666, 1679.7816283883262, 1682.932682692703, 1219.7072702551502, 1224.9203801752858, 1255.3911352993791, 1264.563725514696, 1269.1940617707821, 4887.242477416006, 4926.45808961014, 4927.260910863399, 4932.778024988884, 4952.5542701157065, 5812.779316343615, 5835.649861008353, 5848.561357898175, 5849.1226316052935, 5856.238688970492, 4680.765961701969, 4914.483979182134, 4934.037862616755, 4954.603631709455, 4981.526754958273, 3086.213015680987, 3108.6011294917375, 3112.0352690665513, 3112.4397608430245, 3136.8274744888795, 5394.811181608625, 5420.24116623673, 5427.891442171134, 5428.4028756836715, 5432.076546987022, 5736.225609542658, 5876.588638795243, 5891.351951285355, 5937.753071854959, 5986.640801551921, 5360.8659783504945, 5377.516023557899, 5408.729563521808, 5412.161115027098, 5416.187571864252, 5595.664260144405, 5857.794977175949, 5860.179574859438, 5878.147668587945, 5902.61632993854, 5761.740721667451, 5824.330202026821, 5834.299884013945, 5841.094630332305, 5859.121131830259, 5492.533134683436, 5496.148097044965, 5502.642328248651, 5512.3660779010925, 5529.3964750221985, 4551.158035763395, 4696.506866778939, 4737.715737055788, 4748.667593268438, 4760.952390476051, 5930.280218736518, 5933.495652869382, 5935.821925342247, 5940.46535811779, 5948.940510594839, 5700.201971723879, 5702.1161719931815, 5722.570807189394, 5734.684592347461, 5789.334226563999, 5357.678539287655, 5648.378678345461, 5690.118031705092, 5693.430656934273, 5714.371419143974, 5595.860103497445, 5596.188552659923, 5612.915806262991, 5624.184493248538, 5651.2935883014625, 5429.402765695691, 5631.183478395692, 5706.258186435903, 5749.8275051748515, 5764.221830053057, 5552.750126244248, 5584.497395234286, 5606.411326810789, 5607.775688972395, 5610.438956104357], "value": 4438.6080954350755, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [710.8436144048308, 732.7655150351886, 755.0147058089199, 764.0831002796643, 782.7847341980953, 12527.749445011093, 13030.348482575857, 13065.150765200255, 13071.346432678376, 13072.542461013867, 12632.873671263307, 12707.110502264844, 12708.110432269721, 12746.171498852591, 13457.663558411045, 814.775936617432, 820.2535692519823, 838.1995194589183, 839.8698201778703, 847.3390755210945, 845.720912099009, 847.2713466418875, 847.4237518487427, 847.9067302596709, 853.4282031039219, 877.1666916429417, 890.8040231149137, 891.0198781340538, 895.7312806158159, 897.407710910799, 882.6028287270753, 889.9599518021672, 891.2780647675404, 891.7859713668738, 892.7321803459001, 649.6459429610874, 654.3979538824293, 655.878662447444, 657.086649557116, 661.6361001449184, 12662.620121396372, 12952.0, 13768.105073170213, 13851.861481385258, 13949.0, 13453.932730336384, 13988.090774099754, 14014.92992535041, 14226.535211549111, 14312.856871431257, 10485.737856553571, 10657.307275027099, 10693.0, 11021.173411994132, 11125.777484450347, 3174.746020318369, 3196.9360612787846, 3216.8713251469912, 3218.7907785993834, 3348.866045358183, 66834.66582667055, 67178.0, 67896.3210367895, 68496.6575167126, 68702.0, 10332.586696532055, 10394.896051039545, 10499.790004199873, 10553.419561924014, 10677.786444271227, 21328.36014919555, 21373.67939480909, 21405.357839264536, 21419.57160856774, 21559.56880862405, 6567.540272180901, 6640.136782218281, 6803.2856550062525, 6918.757843475454, 6947.89578156328, 3493.161641206143, 3510.227749895019, 3512.0, 3529.5588051493564, 3601.819909004539, 2840.7585355245037, 2886.4515742008953, 2911.985440072786, 2919.3285544324926, 2919.430711011375, 455.0444067458311, 458.57581736893906, 460.06377022759193, 463.1639889998585, 469.6501106675549, 630.4483576870239, 633.4647223096476, 655.8884989551788, 661.7981515637777, 662.7945336945465, 8970.461772293684, 9037.367384283169, 9053.728388148365, 9198.224105247076, 9369.578368973413, 637.8501052252717, 660.3660485933461, 673.2997682410238, 679.4700133895569, 685.7908337956972, 4075.409065685459, 4246.808893599796, 4277.786110694453, 4305.182015417061, 4328.177646247203, 59297.40702592919, 60520.69739651361, 62635.6868215656, 64071.0, 64082.0, 53643.73178134162, 54571.18143227855, 54670.17994730082, 55250.0, 57438.13842792278, 48077.0, 48924.26613600799, 49080.0, 49456.50543494519, 49758.50241497611, 8157.6329065193395, 8365.414420990472, 8388.496690198608, 8410.411271210956, 8607.913920860712, 34346.48480272848, 34926.82536587301, 34988.47517287192, 35299.11752206215, 35420.0, 39835.2032959345, 40155.19689606133, 40467.595324046386, 40872.18255634811, 41693.0, 10472.895271047191, 10504.78990420172, 10597.0, 10633.734156646145, 11040.447977601249, 11548.133889958455, 11634.127440441831, 11646.475908583965, 11732.354720490455, 12294.0, 10239.539220735234, 10404.68785936423, 10668.1998850085, 10671.839922401015, 10990.725231869268, 10966.780664386828, 11276.605318813803, 11415.942920285346, 11429.257098288585, 11781.175317727677, 9540.570674319533, 9778.462184579916, 9957.9767002489, 9974.451405172786, 10363.274570780275, 8478.2424926529, 8679.783005424915, 8712.0, 8761.38670293099, 9366.344355895295, 7538.547687138789, 8232.259096681088, 8264.917350826414, 8342.749717508485, 8855.64577416922], "value": 6282.024634724232, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1580.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 119.0, 119.0, 120.0, 121.0, 119.0, 120.0, 121.0, 122.0, 120.0], "value": 119.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 127.0, 128.0, 172.0, 128.0, 128.0, 126.0, 126.0, 150.0, 124.0], "value": 136.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 167.0, 171.0, 167.0, 169.0, 164.0, 167.0, 164.0, 166.0], "value": 166.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 76.0, 106.0, 75.0, 76.0, 75.0, 76.0, 97.0, 76.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 111.0, 85.0, 85.0, 85.0, 109.0, 87.0, 86.0, 107.0], "value": 92.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 114.0, 118.0, 115.0, 114.0, 114.0, 114.0], "value": 114.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 152.0, 150.0, 152.0, 149.0, 151.0, 151.0, 149.0, 150.0], "value": 150.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 94.0, 95.0, 95.0, 95.0, 96.0, 94.0, 100.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 74.0, 71.0, 72.0, 73.0, 75.0, 71.0, 73.0, 71.0], "value": 72.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 56.0, 55.0, 57.0, 59.0, 56.0, 56.0, 56.0, 55.0], "value": 56.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 98.0, 84.0, 81.0, 91.0, 83.0, 82.0, 91.0, 82.0, 82.0], "value": 85.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 150.0, 135.0, 134.0, 134.0, 140.0, 140.0, 135.0, 182.0, 139.0], "value": 142.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 196.0, 197.0, 198.0, 194.0, 193.0, 196.0, 202.0, 188.0, 197.0], "value": 195.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 74.0, 71.0, 73.0, 72.0, 72.0, 70.0, 73.0, 74.0], "value": 72.6, "unit": "score"}]}]} 05:59:39 INFO - Return code: 0 05:59:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:59:40 ERROR - # TBPL SUCCESS # 05:59:40 INFO - Running post-action listener: _resource_record_post_action 05:59:40 INFO - [mozharness: 2017-03-20 12:59:40.018637Z] Finished run-tests step (success) 05:59:40 INFO - Running post-run listener: _resource_record_post_run 05:59:40 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 362889216; Read time: 196; Write time: 251308 05:59:40 INFO - TinderboxPrint: CPU usage
13.3% 05:59:40 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 196 05:59:40 INFO - TinderboxPrint: I/O write bytes / time
362,889,216 / 251,308 05:59:40 INFO - TinderboxPrint: CPU idle
8,329.8 (86.7%) 05:59:40 INFO - TinderboxPrint: CPU user
1,218.8 (12.7%) 05:59:40 INFO - TinderboxPrint: Swap in / out
0 / 0 05:59:40 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 105172992; Read time: 0; Write time: 73204 05:59:40 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 257716224; Read time: 196; Write time: 178104 05:59:40 INFO - Running post-run listener: _upload_blobber_files 05:59:40 INFO - Blob upload gear active. 05:59:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:59:40 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:59:40 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'] 05:59:40 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 05:59:41 INFO - (blobuploader) - INFO - Open directory for files ... 05:59:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:59:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:59:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:59:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:59:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:59:42 INFO - (blobuploader) - INFO - Done attempting. 05:59:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:59:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:59:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:59:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:59:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:59:45 INFO - (blobuploader) - INFO - Done attempting. 05:59:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:59:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:59:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:59:46 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:59:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:59:46 INFO - (blobuploader) - INFO - Done attempting. 05:59:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:59:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:59:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:59:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:59:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:59:46 INFO - (blobuploader) - INFO - Done attempting. 05:59:46 INFO - (blobuploader) - INFO - Iteration through files over. 05:59:46 INFO - Return code: 0 05:59:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:59:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:59:46 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5e07083654024fb7b3a707309d82b1c995ce912d5db90ea138bffc4ae5e4d097341405c65232fd4729ad8bf701efc26316be421034ed05fc7b307b825ac28a2c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/82d1fe3c8f5d61337c3203f1f3181e343f8f0a0b948e08a1deee841ad93d5b51b62a4ae9410026021dfb2688b8bb1e57e15564023dcaf7837909e937f1cd9dfa", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/53fbbe24eaa045c3a25d6aa65c4d6e9afb1e0840315e95e058acf105fd29e9966e762cf043a18f15f2d212baf8e7daca5cb61e7a0bd17a174548fbd058dc0b07", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/237c57c3005e8dbcbd1f8ce8bbabc40556e33b41c03f6d01e62ed378104d3a9c1302670c09ec99ac7ca97bbffe3bcf775e7dea5bb2ad50f226245d54f5fba538"} 05:59:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:59:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:59:46 INFO - Contents: 05:59:46 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5e07083654024fb7b3a707309d82b1c995ce912d5db90ea138bffc4ae5e4d097341405c65232fd4729ad8bf701efc26316be421034ed05fc7b307b825ac28a2c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/82d1fe3c8f5d61337c3203f1f3181e343f8f0a0b948e08a1deee841ad93d5b51b62a4ae9410026021dfb2688b8bb1e57e15564023dcaf7837909e937f1cd9dfa", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/53fbbe24eaa045c3a25d6aa65c4d6e9afb1e0840315e95e058acf105fd29e9966e762cf043a18f15f2d212baf8e7daca5cb61e7a0bd17a174548fbd058dc0b07", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/237c57c3005e8dbcbd1f8ce8bbabc40556e33b41c03f6d01e62ed378104d3a9c1302670c09ec99ac7ca97bbffe3bcf775e7dea5bb2ad50f226245d54f5fba538"} 05:59:46 INFO - Running post-run listener: copy_logs_to_upload_dir 05:59:46 INFO - Copying logs to upload dir... 05:59:46 INFO - mkdir: /builds/slave/test/build/upload/logs 05:59:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.472079 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-03-20 05:59:46.599755) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-20 05:59:46.603667) ========= 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=ea65d483da93c827905c2090000001f5-1490013442.628433-1600166000 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/5e07083654024fb7b3a707309d82b1c995ce912d5db90ea138bffc4ae5e4d097341405c65232fd4729ad8bf701efc26316be421034ed05fc7b307b825ac28a2c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/82d1fe3c8f5d61337c3203f1f3181e343f8f0a0b948e08a1deee841ad93d5b51b62a4ae9410026021dfb2688b8bb1e57e15564023dcaf7837909e937f1cd9dfa", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/53fbbe24eaa045c3a25d6aa65c4d6e9afb1e0840315e95e058acf105fd29e9966e762cf043a18f15f2d212baf8e7daca5cb61e7a0bd17a174548fbd058dc0b07", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/237c57c3005e8dbcbd1f8ce8bbabc40556e33b41c03f6d01e62ed378104d3a9c1302670c09ec99ac7ca97bbffe3bcf775e7dea5bb2ad50f226245d54f5fba538"} build_url:https://queue.taskcluster.net/v1/task/IsQj73FnScWDCarTb52gqQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011338 build_url: 'https://queue.taskcluster.net/v1/task/IsQj73FnScWDCarTb52gqQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5e07083654024fb7b3a707309d82b1c995ce912d5db90ea138bffc4ae5e4d097341405c65232fd4729ad8bf701efc26316be421034ed05fc7b307b825ac28a2c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/82d1fe3c8f5d61337c3203f1f3181e343f8f0a0b948e08a1deee841ad93d5b51b62a4ae9410026021dfb2688b8bb1e57e15564023dcaf7837909e937f1cd9dfa", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/53fbbe24eaa045c3a25d6aa65c4d6e9afb1e0840315e95e058acf105fd29e9966e762cf043a18f15f2d212baf8e7daca5cb61e7a0bd17a174548fbd058dc0b07", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/237c57c3005e8dbcbd1f8ce8bbabc40556e33b41c03f6d01e62ed378104d3a9c1302670c09ec99ac7ca97bbffe3bcf775e7dea5bb2ad50f226245d54f5fba538"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-20 05:59:46.628750) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 05:59:46.629078) ========= 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=ea65d483da93c827905c2090000001f5-1490013442.628433-1600166000 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004552 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 05:59:46.712342) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-20 05:59:46.712792) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-20 05:59:46.713367) ========= ========= Total master_lag: 0.15 =========